builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1477752257.41 results: success (0) buildid: 20161029061222 builduid: 9be9fb38df404580bc0ae8e9ab41c447 revision: 16cdd6273c48ea8e7dbc99e343a50b9ca9789715 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.415017) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.415578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.415893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.432688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.433097) ========= 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=62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-29 07:44:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-10-29 07:44:17 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.554265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.554590) ========= 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=62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018290 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.604504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:17.604910) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 16cdd6273c48ea8e7dbc99e343a50b9ca9789715 --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 16cdd6273c48ea8e7dbc99e343a50b9ca9789715 --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=62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-29 07:44:17,981 truncating revision to first 12 chars 2016-10-29 07:44:17,981 Setting DEBUG logging. 2016-10-29 07:44:17,981 attempt 1/10 2016-10-29 07:44:17,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/16cdd6273c48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 07:44:18,283 unpacking tar archive at: mozilla-central-16cdd6273c48/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:18.244611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:18.244989) ========= script_repo_revision: 16cdd6273c48ea8e7dbc99e343a50b9ca9789715 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:18.245448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:18.245715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 07:44:18.255404) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-29 07:44:18.255806) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:44:18 INFO - MultiFileLogger online at 20161029 07:44:18 in /builds/slave/test 07:44:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:44:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:18 INFO - {'append_to_log': False, 07:44:18 INFO - 'base_work_dir': '/builds/slave/test', 07:44:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:44:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:18 INFO - 'branch': 'Firefox-Non-PGO', 07:44:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:18 INFO - 'config_files': ('talos/linux_config.py',), 07:44:18 INFO - 'default_actions': ('clobber', 07:44:18 INFO - 'read-buildbot-config', 07:44:18 INFO - 'download-and-extract', 07:44:18 INFO - 'populate-webroot', 07:44:18 INFO - 'create-virtualenv', 07:44:18 INFO - 'install', 07:44:18 INFO - 'run-tests'), 07:44:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:18 INFO - 'download_minidump_stackwalk': True, 07:44:18 INFO - 'download_symbols': 'ondemand', 07:44:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:18 INFO - 'installer_path': 'installer.exe', 07:44:18 INFO - 'log_level': 'info', 07:44:18 INFO - 'log_name': 'talos', 07:44:18 INFO - 'log_to_console': True, 07:44:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:44:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:44:18 INFO - 'opt_config_files': (), 07:44:18 INFO - 'pip_index': False, 07:44:18 INFO - 'sps_profile': False, 07:44:18 INFO - 'sps_profile_interval': 0, 07:44:18 INFO - 'suite': 'dromaeojs', 07:44:18 INFO - 'system_bits': '32', 07:44:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:18 INFO - 'title': 'talos-linux64-ix-018', 07:44:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:18 INFO - 'use_talos_json': True, 07:44:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:18 INFO - 'work_dir': 'build'} 07:44:18 INFO - [mozharness: 2016-10-29 14:44:18.729537Z] Running clobber step. 07:44:18 INFO - Running pre-action listener: _resource_record_pre_action 07:44:18 INFO - Running main action method: clobber 07:44:18 INFO - rmtree: /builds/slave/test/build 07:44:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:19 INFO - Running post-action listener: _resource_record_post_action 07:44:19 INFO - [mozharness: 2016-10-29 14:44:19.186333Z] Finished clobber step (success) 07:44:19 INFO - [mozharness: 2016-10-29 14:44:19.186432Z] Running read-buildbot-config step. 07:44:19 INFO - Running pre-action listener: _resource_record_pre_action 07:44:19 INFO - Running main action method: read_buildbot_config 07:44:19 INFO - Using buildbot properties: 07:44:19 INFO - { 07:44:19 INFO - "project": "", 07:44:19 INFO - "product": "firefox", 07:44:19 INFO - "script_repo_revision": "production", 07:44:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:44:19 INFO - "repository": "", 07:44:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:44:19 INFO - "buildid": "20161029061222", 07:44:19 INFO - "pgo_build": "False", 07:44:19 INFO - "basedir": "/builds/slave/test", 07:44:19 INFO - "buildnumber": 698, 07:44:19 INFO - "slavename": "talos-linux64-ix-018", 07:44:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:44:19 INFO - "platform": "ubuntu64_hw", 07:44:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:44:19 INFO - "branch": "mozilla-central", 07:44:19 INFO - "repo_path": "mozilla-central", 07:44:19 INFO - "revision": "16cdd6273c48ea8e7dbc99e343a50b9ca9789715", 07:44:19 INFO - "stage_platform": "linux64", 07:44:19 INFO - "builduid": "9be9fb38df404580bc0ae8e9ab41c447", 07:44:19 INFO - "slavebuilddir": "test" 07:44:19 INFO - } 07:44:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:44:19 INFO - Running post-action listener: _resource_record_post_action 07:44:19 INFO - [mozharness: 2016-10-29 14:44:19.188848Z] Finished read-buildbot-config step (success) 07:44:19 INFO - [mozharness: 2016-10-29 14:44:19.188936Z] Running download-and-extract step. 07:44:19 INFO - Running pre-action listener: _resource_record_pre_action 07:44:19 INFO - Running main action method: download_and_extract 07:44:19 INFO - mkdir: /builds/slave/test/build/tests 07:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:19 INFO - trying https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:44:19 INFO - Downloading https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/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 07:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/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 07:44:19 INFO - Downloaded 1361 bytes. 07:44:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:44:19 INFO - Using the following test package requirements: 07:44:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:44:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:44:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'jsshell-linux-x86_64.zip'], 07:44:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:44:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:44:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:44:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:44:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:44:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:44:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:44:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:19 INFO - Fetch https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:44:20 INFO - Http code: 200 07:44:20 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 07:44:20 INFO - x-amz-cf-id: 6_Y09zm-x1kHiutucKge6C5hMmqpG_Q9h-g27u4qGyLpHAp2NL1FrQ== 07:44:20 INFO - x-amz-version-id: twwg.A97XlXKkKz22_.EA3vGH_Wdv6dm 07:44:20 INFO - Expected file size: 20438767 07:44:20 INFO - Obtained file size: 20438767 07:44:24 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 07:44:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:44:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:24 INFO - Fetch https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:44:25 INFO - Http code: 200 07:44:25 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 07:44:25 INFO - x-amz-cf-id: nWDN545cMc6gKODYZNwuA3kAoCzb7mWdwfouU3E0acgs4ifQmBrpjA== 07:44:25 INFO - x-amz-version-id: twwg.A97XlXKkKz22_.EA3vGH_Wdv6dm 07:44:25 INFO - Expected file size: 20438767 07:44:25 INFO - Obtained file size: 20438767 07:44:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:44:29 INFO - Fetch https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:44:30 INFO - Http code: 200 07:44:30 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:44:30 INFO - x-amz-cf-id: AIQTgddCg7r3Ov4XtW-DmI2MZmtvIWcqgMAhby9UgNJuIWBPduvegA== 07:44:30 INFO - x-amz-version-id: IDMJbYuS1fYquEFqtOwh3zB46TxfxoK2 07:44:30 INFO - Expected file size: 14409038 07:44:30 INFO - Obtained file size: 14409038 07:44: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')]} 07:44:30 INFO - trying https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:44:30 INFO - Downloading https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/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 07:44:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/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 07:44:32 INFO - Downloaded 55737116 bytes. 07:44:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:44:32 INFO - mkdir: /builds/slave/test/properties 07:44:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:32 INFO - Contents: 07:44:32 INFO - build_url:https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:44:32 INFO - Running post-action listener: _resource_record_post_action 07:44:32 INFO - Running post-action listener: set_extra_try_arguments 07:44:32 INFO - [mozharness: 2016-10-29 14:44:32.597772Z] Finished download-and-extract step (success) 07:44:32 INFO - [mozharness: 2016-10-29 14:44:32.597998Z] Running populate-webroot step. 07:44:32 INFO - Running pre-action listener: _resource_record_pre_action 07:44:32 INFO - Running main action method: populate_webroot 07:44:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:32 INFO - '--tppagecycles', 07:44:32 INFO - '7'], 07:44:32 INFO - 'tests': ['tsvgm']}}, 07:44:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['damp', 'tps']}, 07:44:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'tests': ['damp', 'tps']}, 07:44:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['dromaeo_dom']}, 07:44:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['basic_compositor_video']}, 07:44:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:44:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['a11yr', 07:44:32 INFO - 'ts_paint', 07:44:32 INFO - 'tpaint', 07:44:32 INFO - 'sessionrestore', 07:44:32 INFO - 'sessionrestore_no_auto_restore', 07:44:32 INFO - 'tabpaint']}, 07:44:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:32 INFO - 'ts_paint', 07:44:32 INFO - 'tpaint', 07:44:32 INFO - 'sessionrestore', 07:44:32 INFO - 'sessionrestore_no_auto_restore', 07:44:32 INFO - 'tabpaint']}, 07:44:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:32 INFO - 'ts_paint', 07:44:32 INFO - 'tpaint', 07:44:32 INFO - 'sessionrestore', 07:44:32 INFO - 'sessionrestore_no_auto_restore', 07:44:32 INFO - 'tabpaint']}, 07:44:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:32 INFO - 'ts_paint', 07:44:32 INFO - 'tpaint', 07:44:32 INFO - 'sessionrestore', 07:44:32 INFO - 'sessionrestore_no_auto_restore', 07:44:32 INFO - 'tabpaint']}, 07:44:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['a11yr', 07:44:32 INFO - 'ts_paint', 07:44:32 INFO - 'tpaint', 07:44:32 INFO - 'sessionrestore', 07:44:32 INFO - 'sessionrestore_no_auto_restore', 07:44:32 INFO - 'tabpaint']}, 07:44:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['a11yr', 07:44:32 INFO - 'ts_paint', 07:44:32 INFO - 'tpaint', 07:44:32 INFO - 'sessionrestore', 07:44:32 INFO - 'sessionrestore_no_auto_restore', 07:44:32 INFO - 'tabpaint']}, 07:44:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['tsvgx', 07:44:32 INFO - 'tsvgr_opacity', 07:44:32 INFO - 'tart', 07:44:32 INFO - 'tscrollx', 07:44:32 INFO - 'cart']}, 07:44:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:32 INFO - 'tsvgr_opacity', 07:44:32 INFO - 'tart', 07:44:32 INFO - 'tscrollx', 07:44:32 INFO - 'cart']}, 07:44:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'talos_options': ['--disable-e10s'], 07:44:32 INFO - 'tests': ['tp5o']}, 07:44:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'tests': ['tp5o']}, 07:44:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'talos_options': ['--disable-e10s', 07:44:32 INFO - '--xperf_path', 07:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:32 INFO - 'tests': ['tp5n']}, 07:44:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:32 INFO - 'talos_options': ['--xperf_path', 07:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:32 INFO - 'tests': ['tp5n']}}, 07:44:32 INFO - 'talos.zip': {'path': '', 07:44:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:32 INFO - Running post-action listener: _resource_record_post_action 07:44:32 INFO - [mozharness: 2016-10-29 14:44:32.618314Z] Finished populate-webroot step (success) 07:44:32 INFO - [mozharness: 2016-10-29 14:44:32.618402Z] Running create-virtualenv step. 07:44:32 INFO - Running pre-action listener: _resource_record_pre_action 07:44:32 INFO - Running main action method: create_virtualenv 07:44:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:32 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 07:44:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:32 INFO - Using real prefix '/usr' 07:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:35 INFO - Installing pip.................done. 07:44:35 INFO - Return code: 0 07:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:44:35 INFO - Reading from file tmpfile_stdout 07:44:35 INFO - Output received: 07:44:35 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) 07:44:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44: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', 'pip>=1.5'] in /builds/slave/test/build 07:44: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 pip>=1.5 07:44:35 INFO - Using env: {'DISPLAY': ':0', 07:44:35 INFO - 'HOME': '/home/cltbld', 07:44:35 INFO - 'LANG': 'en_US.UTF-8', 07:44:35 INFO - 'LANGUAGE': 'en_US:en', 07:44:35 INFO - 'LOGNAME': 'cltbld', 07:44:35 INFO - 'MAIL': '/var/mail/cltbld', 07:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:35 INFO - 'MOZ_NO_REMOTE': '1', 07:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:35 INFO - 'NO_EM_RESTART': '1', 07:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:35 INFO - 'PWD': '/builds/slave/test', 07:44:35 INFO - 'SHELL': '/bin/bash', 07:44:35 INFO - 'SHLVL': '1', 07:44:35 INFO - 'TERM': 'linux', 07:44:35 INFO - 'TMOUT': '86400', 07:44:35 INFO - 'USER': 'cltbld', 07:44:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:35 INFO - '_': '/tools/buildbot/bin/python'} 07:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:35 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 07:44:35 INFO - Cleaning up... 07:44:35 INFO - Return code: 0 07:44:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', '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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:44: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 psutil>=3.1.1 07:44:35 INFO - Using env: {'DISPLAY': ':0', 07:44:35 INFO - 'HOME': '/home/cltbld', 07:44:35 INFO - 'LANG': 'en_US.UTF-8', 07:44:35 INFO - 'LANGUAGE': 'en_US:en', 07:44:35 INFO - 'LOGNAME': 'cltbld', 07:44:35 INFO - 'MAIL': '/var/mail/cltbld', 07:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:35 INFO - 'MOZ_NO_REMOTE': '1', 07:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:35 INFO - 'NO_EM_RESTART': '1', 07:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:35 INFO - 'PWD': '/builds/slave/test', 07:44:35 INFO - 'SHELL': '/bin/bash', 07:44:35 INFO - 'SHLVL': '1', 07:44:35 INFO - 'TERM': 'linux', 07:44:35 INFO - 'TMOUT': '86400', 07:44:35 INFO - 'USER': 'cltbld', 07:44:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:35 INFO - '_': '/tools/buildbot/bin/python'} 07:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:35 INFO - Downloading/unpacking psutil>=3.1.1 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:37 INFO - Installing collected packages: psutil 07:44:37 INFO - Running setup.py install for psutil 07:44:37 INFO - building 'psutil._psutil_linux' extension 07:44:37 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 07:44:38 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 07:44:38 INFO - building 'psutil._psutil_posix' extension 07:44:38 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 07:44:38 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 07:44:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:38 INFO - Successfully installed psutil 07:44:38 INFO - Cleaning up... 07:44:38 INFO - Return code: 0 07:44:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:44: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 mozsystemmonitor==0.3 07:44:38 INFO - Using env: {'DISPLAY': ':0', 07:44:38 INFO - 'HOME': '/home/cltbld', 07:44:38 INFO - 'LANG': 'en_US.UTF-8', 07:44:38 INFO - 'LANGUAGE': 'en_US:en', 07:44:38 INFO - 'LOGNAME': 'cltbld', 07:44:38 INFO - 'MAIL': '/var/mail/cltbld', 07:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:38 INFO - 'MOZ_NO_REMOTE': '1', 07:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:38 INFO - 'NO_EM_RESTART': '1', 07:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:38 INFO - 'PWD': '/builds/slave/test', 07:44:38 INFO - 'SHELL': '/bin/bash', 07:44:38 INFO - 'SHLVL': '1', 07:44:38 INFO - 'TERM': 'linux', 07:44:38 INFO - 'TMOUT': '86400', 07:44:38 INFO - 'USER': 'cltbld', 07:44:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:38 INFO - '_': '/tools/buildbot/bin/python'} 07:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:40 INFO - Installing collected packages: mozsystemmonitor 07:44:40 INFO - Running setup.py install for mozsystemmonitor 07:44:40 INFO - Successfully installed mozsystemmonitor 07:44:40 INFO - Cleaning up... 07:44:40 INFO - Return code: 0 07:44:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44:40 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')]} 07:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:40 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')]} 07:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:40 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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:40 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 07:44:40 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 07:44:40 INFO - Using env: {'DISPLAY': ':0', 07:44:40 INFO - 'HOME': '/home/cltbld', 07:44:40 INFO - 'LANG': 'en_US.UTF-8', 07:44:40 INFO - 'LANGUAGE': 'en_US:en', 07:44:40 INFO - 'LOGNAME': 'cltbld', 07:44:40 INFO - 'MAIL': '/var/mail/cltbld', 07:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:40 INFO - 'MOZ_NO_REMOTE': '1', 07:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:40 INFO - 'NO_EM_RESTART': '1', 07:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:40 INFO - 'PWD': '/builds/slave/test', 07:44:40 INFO - 'SHELL': '/bin/bash', 07:44:40 INFO - 'SHLVL': '1', 07:44:40 INFO - 'TERM': 'linux', 07:44:40 INFO - 'TMOUT': '86400', 07:44:40 INFO - 'USER': 'cltbld', 07:44:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:40 INFO - '_': '/tools/buildbot/bin/python'} 07:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:41 INFO - Downloading/unpacking jsonschema==2.5.1 07:44:41 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 07:44:41 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 07:44:41 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 07:44:41 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 07:44:41 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 07:44:41 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 07:44:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:42 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 07:44:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:43 INFO - warning: no files found matching '*.txt' 07:44:43 INFO - no previously-included directories found matching 'build' 07:44:43 INFO - no previously-included directories found matching 'dist' 07:44:43 INFO - no previously-included directories found matching '.git*' 07:44:43 INFO - Installing collected packages: jsonschema, functools32 07:44:43 INFO - Running setup.py install for functools32 07:44:43 INFO - warning: no files found matching '*.txt' 07:44:43 INFO - no previously-included directories found matching 'build' 07:44:43 INFO - no previously-included directories found matching 'dist' 07:44:43 INFO - no previously-included directories found matching '.git*' 07:44:43 INFO - Successfully installed jsonschema functools32 07:44:43 INFO - Cleaning up... 07:44:43 INFO - Return code: 0 07:44:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:44:43 INFO - Using env: {'DISPLAY': ':0', 07:44:43 INFO - 'HOME': '/home/cltbld', 07:44:43 INFO - 'LANG': 'en_US.UTF-8', 07:44:43 INFO - 'LANGUAGE': 'en_US:en', 07:44:43 INFO - 'LOGNAME': 'cltbld', 07:44:43 INFO - 'MAIL': '/var/mail/cltbld', 07:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:43 INFO - 'MOZ_NO_REMOTE': '1', 07:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:43 INFO - 'NO_EM_RESTART': '1', 07:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:43 INFO - 'PWD': '/builds/slave/test', 07:44:43 INFO - 'SHELL': '/bin/bash', 07:44:43 INFO - 'SHLVL': '1', 07:44:43 INFO - 'TERM': 'linux', 07:44:43 INFO - 'TMOUT': '86400', 07:44:43 INFO - 'USER': 'cltbld', 07:44:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:43 INFO - '_': '/tools/buildbot/bin/python'} 07:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:44:43 INFO - Cleaning up... 07:44:43 INFO - Return code: 0 07:44:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:44:43 INFO - Using env: {'DISPLAY': ':0', 07:44:43 INFO - 'HOME': '/home/cltbld', 07:44:43 INFO - 'LANG': 'en_US.UTF-8', 07:44:43 INFO - 'LANGUAGE': 'en_US:en', 07:44:43 INFO - 'LOGNAME': 'cltbld', 07:44:43 INFO - 'MAIL': '/var/mail/cltbld', 07:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:43 INFO - 'MOZ_NO_REMOTE': '1', 07:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:43 INFO - 'NO_EM_RESTART': '1', 07:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:43 INFO - 'PWD': '/builds/slave/test', 07:44:43 INFO - 'SHELL': '/bin/bash', 07:44:43 INFO - 'SHLVL': '1', 07:44:43 INFO - 'TERM': 'linux', 07:44:43 INFO - 'TMOUT': '86400', 07:44:43 INFO - 'USER': 'cltbld', 07:44:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:43 INFO - '_': '/tools/buildbot/bin/python'} 07:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:43 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 07:44:43 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 07:44:43 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 07:44:43 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 07:44:43 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 07:44:43 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 07:44:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:45 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 07:44:45 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 07:44:45 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 07:44:45 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 07:44:45 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 07:44:45 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 07:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:46 INFO - Downloading docopt-0.6.1.tar.gz 07:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:46 INFO - Running setup.py install for blobuploader 07:44:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:46 INFO - Running setup.py install for requests 07:44:47 INFO - Running setup.py install for docopt 07:44:47 INFO - Successfully installed blobuploader requests docopt 07:44:47 INFO - Cleaning up... 07:44:47 INFO - Return code: 0 07:44:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:47 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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:47 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 07:44:47 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 07:44:47 INFO - Using env: {'DISPLAY': ':0', 07:44:47 INFO - 'HOME': '/home/cltbld', 07:44:47 INFO - 'LANG': 'en_US.UTF-8', 07:44:47 INFO - 'LANGUAGE': 'en_US:en', 07:44:47 INFO - 'LOGNAME': 'cltbld', 07:44:47 INFO - 'MAIL': '/var/mail/cltbld', 07:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:47 INFO - 'MOZ_NO_REMOTE': '1', 07:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:47 INFO - 'NO_EM_RESTART': '1', 07:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:47 INFO - 'PWD': '/builds/slave/test', 07:44:47 INFO - 'SHELL': '/bin/bash', 07:44:47 INFO - 'SHLVL': '1', 07:44:47 INFO - 'TERM': 'linux', 07:44:47 INFO - 'TMOUT': '86400', 07:44:47 INFO - 'USER': 'cltbld', 07:44:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:47 INFO - '_': '/tools/buildbot/bin/python'} 07:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:47 INFO - Running setup.py (path:/tmp/pip-7UCBqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:47 INFO - Running setup.py (path:/tmp/pip-bC2lUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:47 INFO - Running setup.py (path:/tmp/pip-aZl9rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:47 INFO - Running setup.py (path:/tmp/pip-W74q1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:47 INFO - Running setup.py (path:/tmp/pip-iDQhkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:47 INFO - Running setup.py (path:/tmp/pip-FLuigk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:47 INFO - Running setup.py (path:/tmp/pip-7gozuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:47 INFO - Running setup.py (path:/tmp/pip-y140vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:47 INFO - Running setup.py (path:/tmp/pip-Q2EIeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:48 INFO - Running setup.py (path:/tmp/pip-2g9lGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:48 INFO - Running setup.py (path:/tmp/pip-3n2fwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:48 INFO - Running setup.py (path:/tmp/pip-opHBSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:48 INFO - Running setup.py (path:/tmp/pip-zUQwwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:48 INFO - Running setup.py (path:/tmp/pip-coNMZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:48 INFO - Running setup.py (path:/tmp/pip-Yt59Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:48 INFO - Running setup.py (path:/tmp/pip-07z_lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:48 INFO - Running setup.py (path:/tmp/pip-BQFRXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:48 INFO - Running setup.py install for manifestparser 07:44:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:48 INFO - Running setup.py install for mozcrash 07:44:48 INFO - Running setup.py install for mozdebug 07:44:48 INFO - Running setup.py install for mozdevice 07:44:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for mozfile 07:44:49 INFO - Running setup.py install for mozhttpd 07:44:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for mozinfo 07:44:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for mozInstall 07:44:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for mozleak 07:44:49 INFO - Running setup.py install for mozlog 07:44:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for moznetwork 07:44:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for mozprocess 07:44:49 INFO - Running setup.py install for mozprofile 07:44:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:49 INFO - Running setup.py install for mozrunner 07:44:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:50 INFO - Running setup.py install for mozscreenshot 07:44:50 INFO - Running setup.py install for moztest 07:44:50 INFO - Running setup.py install for mozversion 07:44:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:50 INFO - Cleaning up... 07:44:50 INFO - Return code: 0 07:44:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:50 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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:50 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 07:44:50 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 07:44:50 INFO - Using env: {'DISPLAY': ':0', 07:44:50 INFO - 'HOME': '/home/cltbld', 07:44:50 INFO - 'LANG': 'en_US.UTF-8', 07:44:50 INFO - 'LANGUAGE': 'en_US:en', 07:44:50 INFO - 'LOGNAME': 'cltbld', 07:44:50 INFO - 'MAIL': '/var/mail/cltbld', 07:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:50 INFO - 'MOZ_NO_REMOTE': '1', 07:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:50 INFO - 'NO_EM_RESTART': '1', 07:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:50 INFO - 'PWD': '/builds/slave/test', 07:44:50 INFO - 'SHELL': '/bin/bash', 07:44:50 INFO - 'SHLVL': '1', 07:44:50 INFO - 'TERM': 'linux', 07:44:50 INFO - 'TMOUT': '86400', 07:44:50 INFO - 'USER': 'cltbld', 07:44:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:50 INFO - '_': '/tools/buildbot/bin/python'} 07:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:50 INFO - Running setup.py (path:/tmp/pip-zwyTM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:50 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)) 07:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:50 INFO - Running setup.py (path:/tmp/pip-UMZAVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:50 INFO - Running setup.py (path:/tmp/pip-Q4VLpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:50 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)) 07:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:50 INFO - Running setup.py (path:/tmp/pip-RppcJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:50 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)) 07:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:50 INFO - Running setup.py (path:/tmp/pip-6Ivyxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:51 INFO - Running setup.py (path:/tmp/pip-5K_T9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:51 INFO - Running setup.py (path:/tmp/pip-gf_Cbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:51 INFO - Running setup.py (path:/tmp/pip-941rWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:51 INFO - Running setup.py (path:/tmp/pip-BK53bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:51 INFO - Running setup.py (path:/tmp/pip-ZsCW2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:51 INFO - Running setup.py (path:/tmp/pip-SwQ4nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:51 INFO - Running setup.py (path:/tmp/pip-mjkMa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:51 INFO - Running setup.py (path:/tmp/pip-q4ZCLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:51 INFO - Running setup.py (path:/tmp/pip-DjvS5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:51 INFO - Running setup.py (path:/tmp/pip-3Cf238-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:51 INFO - Running setup.py (path:/tmp/pip-DWQK_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:51 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)) 07:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:51 INFO - Running setup.py (path:/tmp/pip-cjyzix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:51 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)) 07:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:44:51 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)) 07:44:51 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)) 07:44:51 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)) 07:44:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:54 INFO - Downloading blessings-1.6.tar.gz 07:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:54 INFO - Installing collected packages: blessings 07:44:54 INFO - Running setup.py install for blessings 07:44:54 INFO - Successfully installed blessings 07:44:54 INFO - Cleaning up... 07:44:55 INFO - Return code: 0 07:44:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:55 INFO - Reading from file tmpfile_stdout 07:44:55 INFO - Current package versions: 07:44:55 INFO - argparse == 1.2.1 07:44:55 INFO - blessings == 1.6 07:44:55 INFO - blobuploader == 1.2.4 07:44:55 INFO - docopt == 0.6.1 07:44:55 INFO - functools32 == 3.2.3-2 07:44:55 INFO - jsonschema == 2.5.1 07:44:55 INFO - manifestparser == 1.1 07:44:55 INFO - mozInstall == 1.12 07:44:55 INFO - mozcrash == 0.17 07:44:55 INFO - mozdebug == 0.1 07:44:55 INFO - mozdevice == 0.48 07:44:55 INFO - mozfile == 1.2 07:44:55 INFO - mozhttpd == 0.7 07:44:55 INFO - mozinfo == 0.9 07:44:55 INFO - mozleak == 0.1 07:44:55 INFO - mozlog == 3.4 07:44:55 INFO - moznetwork == 0.27 07:44:55 INFO - mozprocess == 0.23 07:44:55 INFO - mozprofile == 0.28 07:44:55 INFO - mozrunner == 6.12 07:44:55 INFO - mozscreenshot == 0.1 07:44:55 INFO - mozsystemmonitor == 0.3 07:44:55 INFO - moztest == 0.7 07:44:55 INFO - mozversion == 1.4 07:44:55 INFO - psutil == 3.1.1 07:44:55 INFO - requests == 1.2.3 07:44:55 INFO - wsgiref == 0.1.2 07:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 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 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:55 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 07:44:55 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 07:44:55 INFO - Using env: {'DISPLAY': ':0', 07:44:55 INFO - 'HOME': '/home/cltbld', 07:44:55 INFO - 'LANG': 'en_US.UTF-8', 07:44:55 INFO - 'LANGUAGE': 'en_US:en', 07:44:55 INFO - 'LOGNAME': 'cltbld', 07:44:55 INFO - 'MAIL': '/var/mail/cltbld', 07:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:55 INFO - 'MOZ_NO_REMOTE': '1', 07:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:55 INFO - 'NO_EM_RESTART': '1', 07:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:55 INFO - 'PWD': '/builds/slave/test', 07:44:55 INFO - 'SHELL': '/bin/bash', 07:44:55 INFO - 'SHLVL': '1', 07:44:55 INFO - 'TERM': 'linux', 07:44:55 INFO - 'TMOUT': '86400', 07:44:55 INFO - 'USER': 'cltbld', 07:44:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:55 INFO - '_': '/tools/buildbot/bin/python'} 07:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 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)) 07:44:55 INFO - Cleaning up... 07:44:55 INFO - Return code: 0 07:44:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57eb8e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, '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': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', '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 07:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:44:55 INFO - Using env: {'DISPLAY': ':0', 07:44:55 INFO - 'HOME': '/home/cltbld', 07:44:55 INFO - 'LANG': 'en_US.UTF-8', 07:44:55 INFO - 'LANGUAGE': 'en_US:en', 07:44:55 INFO - 'LOGNAME': 'cltbld', 07:44:55 INFO - 'MAIL': '/var/mail/cltbld', 07:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:55 INFO - 'MOZ_NO_REMOTE': '1', 07:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:55 INFO - 'NO_EM_RESTART': '1', 07:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:55 INFO - 'PWD': '/builds/slave/test', 07:44:55 INFO - 'SHELL': '/bin/bash', 07:44:55 INFO - 'SHLVL': '1', 07:44:55 INFO - 'TERM': 'linux', 07:44:55 INFO - 'TMOUT': '86400', 07:44:55 INFO - 'USER': 'cltbld', 07:44:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:55 INFO - '_': '/tools/buildbot/bin/python'} 07:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:44:55 INFO - Cleaning up... 07:44:55 INFO - Return code: 0 07:44:55 INFO - Running post-action listener: _resource_record_post_action 07:44:55 INFO - Running post-action listener: _start_resource_monitoring 07:44:55 INFO - Starting resource monitoring. 07:44:55 INFO - [mozharness: 2016-10-29 14:44:55.762850Z] Finished create-virtualenv step (success) 07:44:55 INFO - [mozharness: 2016-10-29 14:44:55.763355Z] Running install step. 07:44:55 INFO - Running pre-action listener: _resource_record_pre_action 07:44:55 INFO - Running main action method: install 07:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:55 INFO - Reading from file tmpfile_stdout 07:44:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:56 INFO - Reading from file tmpfile_stdout 07:44:56 INFO - Output received: 07:44:56 INFO - Usage: mozinstall [options] installer 07:44:56 INFO - Options: 07:44:56 INFO - -h, --help show this help message and exit 07:44:56 INFO - -d DEST, --destination=DEST 07:44:56 INFO - Directory to install application into. [default: 07:44:56 INFO - "/builds/slave/test"] 07:44:56 INFO - --app=APP Application being installed. [default: firefox] 07:44:56 INFO - mkdir: /builds/slave/test/build/application 07:44:56 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'] 07:44:56 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 07:45:12 INFO - Reading from file tmpfile_stdout 07:45:12 INFO - Output received: 07:45:12 INFO - /builds/slave/test/build/application/firefox/firefox 07:45:12 INFO - Running post-action listener: _resource_record_post_action 07:45:12 INFO - [mozharness: 2016-10-29 14:45:12.139054Z] Finished install step (success) 07:45:12 INFO - [mozharness: 2016-10-29 14:45:12.139298Z] Running run-tests step. 07:45:12 INFO - Running pre-action listener: _resource_record_pre_action 07:45:12 INFO - Running main action method: run_tests 07:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:12 INFO - Python 2.7.3 07:45:12 INFO - Return code: 0 07:45:12 INFO - grabbing minidump binary from tooltool 07:45:12 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')]} 07:45:12 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 0xf34f60>, '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 0xf35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf361d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:12 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 07:45:12 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 07:45:12 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 07:45:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:12 INFO - Return code: 0 07:45:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:45:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:45:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 07:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 07:45:12 INFO - Using env: {'DISPLAY': ':0', 07:45:12 INFO - 'HOME': '/home/cltbld', 07:45:12 INFO - 'LANG': 'en_US.UTF-8', 07:45:12 INFO - 'LANGUAGE': 'en_US:en', 07:45:12 INFO - 'LOGNAME': 'cltbld', 07:45:12 INFO - 'MAIL': '/var/mail/cltbld', 07:45:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:12 INFO - 'MOZ_NO_REMOTE': '1', 07:45:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:12 INFO - 'NO_EM_RESTART': '1', 07:45:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:12 INFO - 'PWD': '/builds/slave/test', 07:45:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:12 INFO - 'SHELL': '/bin/bash', 07:45:12 INFO - 'SHLVL': '1', 07:45:12 INFO - 'TERM': 'linux', 07:45:12 INFO - 'TMOUT': '86400', 07:45:12 INFO - 'USER': 'cltbld', 07:45:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092', 07:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:12 INFO - '_': '/tools/buildbot/bin/python'} 07:45:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 07:45:12 INFO - mozversion application_buildid: 20161029061222 07:45:12 INFO - mozversion application_changeset: 16cdd6273c48ea8e7dbc99e343a50b9ca9789715 07:45:12 INFO - mozversion application_display_name: Nightly 07:45:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:12 INFO - mozversion application_name: Firefox 07:45:12 INFO - mozversion application_remotingname: firefox 07:45:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:45:12 INFO - mozversion application_vendor: Mozilla 07:45:12 INFO - mozversion application_version: 52.0a1 07:45:12 INFO - mozversion platform_buildid: 20161029061222 07:45:12 INFO - mozversion platform_changeset: 16cdd6273c48ea8e7dbc99e343a50b9ca9789715 07:45:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:45:12 INFO - mozversion platform_version: 52.0a1 07:45:12 INFO - using testdate: 1477752312 07:45:12 INFO - actual date: 1477752312 07:45:12 INFO - starting webserver on 'localhost:60210' 07:45:12 INFO - SUITE-START | Running 2 tests 07:45:12 INFO - TEST-START | dromaeo_css 07:45:12 INFO - operating with platform_type : linux_ 07:45:12 INFO - Initialising browser for dromaeo_css test... 07:45:12 INFO - TEST-INFO | started process 30914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Zku47/profile http://localhost:60210/getInfo.html) 07:45:16 INFO - PROCESS | 30914 | __metrics Screen width/height:1600/1200 07:45:16 INFO - PROCESS | 30914 | colorDepth:24 07:45:16 INFO - PROCESS | 30914 | Browser inner width/height: 1024/697 07:45:16 INFO - PROCESS | 30914 | __metrics 07:45:17 INFO - PROCESS | 30914 | 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" 07:45:17 INFO - PROCESS | 30914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:17 INFO - PROCESS | 30914 | console.error: PushService: 07:45:17 INFO - PROCESS | 30914 | stateChangeProcessEnqueue: Error transitioning state 07:45:17 INFO - PROCESS | 30914 | UnknownError 07:45:18 INFO - TEST-INFO | 30914: exit 0 07:45:18 INFO - Browser initialized. 07:45:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:18 INFO - TEST-INFO | started process 30994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Zku47/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:30 INFO - PROCESS | 30994 | RSS: Main: 176357376 07:45:30 INFO - PROCESS | 30994 | 07:46:21 INFO - PROCESS | 30994 | 1477752381990 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] 07:48:35 INFO - PROCESS | 30994 | Cycle 1(1): loaded http://localhost:60210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60210/tests/dromaeo/cssquery-ext.html) 07:48:36 INFO - PROCESS | 30994 | RSS: Main: 301920256 07:48:36 INFO - PROCESS | 30994 | 07:51:39 INFO - PROCESS | 30994 | Cycle 1(1): loaded http://localhost:60210/tests/dromaeo/cssquery-ext.html (next: http://localhost:60210/tests/dromaeo/cssquery-jquery.html) 07:51:39 INFO - PROCESS | 30994 | RSS: Main: 274829312 07:51:39 INFO - PROCESS | 30994 | 07:54:42 INFO - PROCESS | 30994 | Cycle 1(1): loaded http://localhost:60210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60210/tests/dromaeo/cssquery-mootools.html) 07:54:42 INFO - PROCESS | 30994 | RSS: Main: 261779456 07:54:42 INFO - PROCESS | 30994 | 07:57:44 INFO - PROCESS | 30994 | Cycle 1(1): loaded http://localhost:60210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60210/tests/dromaeo/cssquery-prototype.html) 07:57:45 INFO - PROCESS | 30994 | RSS: Main: 220364800 07:57:45 INFO - PROCESS | 30994 | 08:00:48 INFO - PROCESS | 30994 | Cycle 1(1): loaded http://localhost:60210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60210/tests/dromaeo/cssquery-yui.html) 08:00:49 INFO - PROCESS | 30994 | RSS: Main: 219250688 08:00:49 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | Cycle 1(1): loaded http://localhost:60210/tests/dromaeo/cssquery-yui.html (next: http://localhost:60210/tests/dromaeo/cssquery-dojo.html) 08:03:51 INFO - PROCESS | 30994 | RSS: Main: 317681664 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | __start_tp_report 08:03:51 INFO - PROCESS | 30994 | _x_x_mozilla_page_load 08:03:51 INFO - PROCESS | 30994 | _x_x_mozilla_page_load_details 08:03:51 INFO - PROCESS | 30994 | |i|pagename|runs| 08:03:51 INFO - PROCESS | 30994 | |0;dojo.html;2448.620463828105;2453.98773006135;2480.9827970532087;2496.0515004298377;2499;4401.537838526957;4447.688661793676;4490.10197960408;4492.191405547001;4503.0318481526465;4475.865724028285;4483.991102002048;4498.437695288089;4502.842400515982;4551.772411379435;4082.7754473503946;4086.9182616347657;4129.298019336705;4140.213359461708;4172.666186705072;3823.8279277432443;4169.9791501042455;4188.895277618053;4202.873913782591;4246.447961764966;4233.470816147981;4278.122984788142;4279.743215407086;4306.655467562603;4336.111097225062;4073.5722749111214;4107.835686572534;4112.876613701594;4153.522344930341;4159.376093585956;4096.078382363974;4112.259793237216;4122.093139509303;4135.9172816543805;4184.14225083857;4473.575010374042;4480.215962206634;4482.731036137842;4511.4135162429;4551.886202844922;4713.740744259065;4796.136695394827;4797.784099715521;4810.903781924377;4855.271709243606;4777.546133117348;4827.08285425768;4839.27410888366;4842.370491836039;4858.732769697665;4520.547945205486;4528.343390208402;4532.546745325441;4533.977330113361;4598.103369842848;4952.603791696728;4958.677685950402;5013.072581572421;5014.0974624567925;5017.598592112622;4728.078024785203;4730.668853180313;4742.146413645577;4743;4796.112719146969;4678.8596342109795;4767.4994125617;4827.903441931212;4829.5653391194255;4853.49038350968;4672.182368085571;4743.312219728189;4748.596369308648;4754.405699287589;4782.378290822171;4711.411073615798;4722.929156062662;4734.171519983989;4745.691530050535;4845.079434907357;4177.811998460076;4186.665066794649;4201.117765269267;4225.66194704429;4245.80893859777;3557.519734835764;3572.6427357264583;3621.5473065866768;3623.963760362363;3666.211764470652;4109.465769449952;4153.314703073959;4154.522229943595;4154.667626589866;4164.916701665949;4797.664163508521;4838.879028024257;4842.346283251786;4845.41854977405;4884.658073934862;4072.6131017553284;4112.568180341081;4145.813438395279;4147.598105883864;4157.210130075276;4350.934735978963;4384.101259241847;4399.252127138394;4407.427034485497;4470.977645111753;4509.34614480905;4513.68404211702;4534.523874993144;4568.977155114336;4570.108828778356;4841.636877234151;4857.587105096107;4858.5384388483035;4862.246351815475;4926.802927882844;4385.254506733799;4425.048614547888;4428.047969686533;4509.797059132281;4521.1409832131785;4747.074320507468;4794.832180873653;4803.3995750531185;4813.614910807057;4889;4879.536444037811;4885.658003939832;4895.143349913679;4901.044296362318;4957.380327459067;4646.62826973848;4719.52804719539;4754.025424787979;4760.000399916056;4820.084184005028;4668.206404911241;4686.742229177428;4712.175369310426;4755.2153894607;4764.547368000034;4630.907381852411;4631.560001799824;4678.719276843401;4705.270683044134;4710.29345598163;4734.384530011076;4734.810607575659;4741.525847415231;4741.905161896674;4798.904021919472;4482.103579284091;4613.2388155953895;4616.515265897033;4676.018036212434;4678.836240731558 08:03:51 INFO - PROCESS | 30994 | |1;ext.html;550.0813641219164;552.549672017306;552.8673118451572;562.4459906991613;574.8447919061854;28372.574411383845;39900.2019959601;41556;41675.16649667005;45340.54659453405;42125;42666.786666066706;42669;42687.14625707484;42746.78626606863;7752.728654497094;7889.5266284022855;7904.446688731791;7907.327877130451;7907.960460197691;7790.337821285169;7877.291043806056;7894.486858354188;7899.9210007899765;7914.050313962332;7776.53340799551;7837.294643482085;7898.6445609947405;7901.367890568769;7909.1299957004685;7782.688692452295;7811.726589569338;7829.765107046769;7836.725714599962;7874.409419293519;7694.9230507694765;7749.186335434811;7755.922440775576;7756.767296981099;7757.922420775776;39068;39407;39485.40771888424;39487.21025579472;39523.60476395228;2868.153894601098;2987.760979121665;3411.573553305837;3464.7747896386654;3474.6351633078666;26554.73445265542;29227.56158657622;29503.70496295031;29520.557191642143;29537.409251815057;3471;3535.222251104753;3581.194231297963;3610.606466728225;3673.045008297835;238532;240143;242522;242665.78667106727;243554;55020;55276.72361638166;55312.44687553073;55341.723291383285;55381;59218;59237.407625924054;59309.70345148247;59311.40688593145;59374.140680855606;15314.310856011507;15565.84434155644;15575.532734017997;15584.532464026097;15594.610134746496;11822.645320640395;11872.643820685393;11890.762184756257;11892.702682433008;11898.76202475963;17892.373766918095;18335.90832045831;18360.173792179383;18489;18552.350667726565;6664.766733164316;6804.3195680432555;6897.517173797886;6926.67956234657;7189.130825985281;731.9743808966767;914.7301546043933;915.9908400915906;953.9427634341823;976.2531663277598;27213.727862721516;27483.17550473489;28216.29459263535;28368.71631283661;28587.42825143527;762.7254188492138;944.9480278584743;954.8042651256476;977.8679878216492;983.0759086458849;13765.793513097311;14639.853601463848;14645.048071875293;14790.852091478948;14830.110193388431;366257;366409;367286;367665;368265.06277091906;50491.74754126279;50841.23738143931;50932.236016459785;50949.235761463606;50970.74514627403;1156.8669602995762;1186.1104171871098;1188.5839956015498;1193.4450480526423;1212.3271584270815;25589.74410255948;26609.600855986788;26744.465110698067;27482;27603;42207.788961055;42662.146757065304;42781;42807.35788963106;42855;246682;247716;247862;247960;249587;25069.247922562354;25861.353466163495;25900.337939170375;25906.61140082938;26059.478810424065;42120.78939605282;42614.14771704486;42642.78678606587;42680.78659606682;43845.78077109594;35595.288094237454;36102.8194859024;36296.27407451889;36551;36808.07979800419;36029.09927251735;36399;36643.26713465663;36648.45027324645;36940.44589331109;30680.539791902695;31463.68536314699;35595.82202088973;36094.45858312075;37007;29224.109490437888;31947.201319966258;33656.941750485144;36380.454293185096;36963.63036369602;24979.625305620066;25784.484310314063;25951.870240648677;25992.740072599034;26337.60493592636 08:03:51 INFO - PROCESS | 30994 | |2;jquery.html;355.49697178492437;355.55555555555554;365.1419164962339;368.7308264966576;386.5438782236961;15746.448874289403;16904.830951690496;17714.291428342884;17777.37779177729;17847.196876140573;16441.83558164418;16636.66726665469;17285.30858765651;17287.481375558753;17393.304267829302;4817.927731084036;5117.053345131144;5119.10415677255;5119.667221630601;5122.513361230677;3634.182308980485;3815;5004.599632029429;5734.254546908917;6047.909281360783;6006.519478441714;6007.4593286604195;6017.969910150443;6027.72875220614;6028.788992385267;5669.773209071632;5849.122631605272;5858;5869.530437564985;5872.148538461942;4996;5136.922946155811;5140.820071297524;5144.639875208737;5145.30538377318;20473.89763051175;20885;20955;21037.158513659437;21050.368488945354;1779.5195297269795;1803.1975770782008;1807.3132209760338;1835.4126679462577;1886.6604011277964;12173.634790956285;12970.577985761955;13273;13367.398467069006;13505.86494135056;1627.7726892596831;1678.5048410718866;1716.6566686662593;1733.8612910967092;1778.97331540027;68412.6579367105;71200;71839;72905;74110.62944685297;9216.308776841764;9374.500239884757;9375.437333813245;9419.529023548796;9430.746392494715;12764.234145951272;12773.23360598367;12830.29433381173;12852.100352975389;12859.421326040163;7240.637968101574;7260.293830949722;7362.263773622595;7433.293837085468;7538.057742782153;7011.439084873198;7075.82310442243;7178.066851309401;7240.818979525554;7241.42068634508;5145.794168233228;5521.309836270466;5561.805336813273;5823.854403639943;5963.880722385528;1624.2771966474804;1651.1826645810402;1751.3799735245102;1762.0396883698415;1764.0826770079743;846.34408333542;876.5792419638609;902.697596305245;932.6222879733718;942.6276620734772;15828.44600438979;16648.08435536033;17748.29006839738;18646.44060678182;19073;844.5186243840951;847.5338563789891;852.8422241885271;856.0497847389393;868.3010176807604;6891.414229790524;9762.219022478184;9856.45789481571;9922.107010369102;9981.900180998096;377704;378774;394511;394780;394826;47598.28602570964;47948.7602561985;47955.520444795104;65509.34490655032;72190;921.9170274675312;923.2752289452748;935.5135329628555;941.8351788436996;944.3473920638882;15088.471903483325;15210.502941602017;15757.212139393214;15924.257799416897;16056.591511273402;33878.491822622185;34874.47688284627;36487.45268821023;37741.24517509689;41220.38169427401;50322.49677503324;50425.49574504208;51717;51941;52472.737636313104;6887.621180834902;7084.397826184832;7474.551526908403;7564.546127232384;7572.356349710116;9906.653267135616;10991.395473249047;11189.440527973406;11442.37066961325;11537.365444900612;9322;9531.332806703464;10098.798024039625;10218.489075546342;10545.9472702636;9580.856287155559;9641;9668.854967175357;9874.55564499585;10019.749506262402;10087.798244034931;10123;10137.79724405493;10211.540480678239;10700.892991070301;7398.223186565333;7414.295641914009;7444.404447644067;7609;7797.727079552188;9757.414555126716;10012.098911098035;10029.092251880158;10354.896451035393;10488.108510776365 08:03:51 INFO - PROCESS | 30994 | |3;mootools.html;1306.8039794030897;1351.0812647399766;1353.776626856568;1588.7378582533881;1644.8355164483553;5943.643381397108;6135.969320153393;6369.968150159249;6747.79756607302;6752.628605426699;6389.137466442029;6613.603183808975;6640.734370625181;6806.863862722743;6811.761588344409;2086.061272427406;2111.862728922623;2113.260358874397;2113.5350222950924;2115.947101322464;1801.0364455016568;2055.239561362298;2100.5063810004635;2110.67284570891;2124.75565309989;1792.9910350448295;2009.3971808457477;2071.85497015209;2083.208380815288;2091.4144039668918;1986.3147214211074;1990.0348331059424;1995.4013795861183;2000.679891217413;2002.819746222847;2061.134323584098;2072.7927207279304;2076.709260703503;2079.07481170879;2082.2295750572234;6652.467802575782;6723.495737819634;6728.83177920551;6733.4276586490205;6758.391744742997;4144.088300573869;4283.892902677427;4285.3786201000685;4291.377750226231;4292.9141417171795;2493.463905260378;2654.5089158505543;2664.5203863304596;2672.2918426616766;2672.692640346366;779.6881247500988;820.024171236233;826.3100311240122;834.9081601023883;835.5195762436623;8791.736247912573;8807.119288071206;8844.027157012788;8848.159424854628;8861.025287218401;3770.7549009314307;3865.6714179294513;3949.9802500987885;3957.2085582883537;3977.940330895039;7518.436117291225;7522.473426860177;7523.7366692165515;7547.245275472519;7551.886721699179;4221.915561688749;4302.677299202573;4308.267594508941;4316.913661726748;4319.524852266248;3823.9808800955816;3892.2993861104706;3899.9610003900166;3900.1419687668667;3900.7269491135917;3262.363839051362;3290.276139249361;3357.9496307555405;3374.4432168692383;3420.1449637590604;1000.2598077422655;1044.738815296176;1046.7330830638139;1056.4031322303028;1061.7929503746695;689.441552342604;703.5356664601441;743.6616339565485;772.5094564951296;783.5103060587134;4526.683132180716;4584.1977653910435;4601.44782626087;4642.72143671374;4659.906801863944;824.8226631274305;827.3877330775183;828.2628460670009;832.5587438657521;848.3637272045966;3055.3431012332453;3126.812391256532;3138.6076740407448;3185.2514659055105;3251.650799676337;7461;7823.765287041398;7849.411294152847;7858.567778772108;7868.488548244346;7812.062552493623;7819.687212511436;7820.960895195602;7823.256790604997;7830.334421574116;6159.84600384994;6243.687815609202;6244.65654389013;6246.906296405557;6248.4688801452385;4334.674899382622;4487.461504619467;4508.616767574662;4574.428196475441;4636.582707556201;7056.611886346095;7069.6111713856235;7111.075560177143;7143.535670181422;7186.425085993003;7199.568025918462;7238.0952380952385;7274.236205198378;7325.267473252632;7453.440991925736;6369.840753981188;6404.775832845828;6408.647524386017;6500.447461965786;6511.218653761579;6328.778492752916;6424.614523128627;6438.259600146043;6438.67806609677;6446.0975463434215;5863.882722345615;5956.463918247378;5974.731137098754;5981.970090149522;5985.820425387245;5759.308882934075;5761.164631128379;5762.711864406847;5789.623674461147;5922.230110085661;5405.5135037846785;5555.0834112371;5591.161325801162;5704.372519022987;5706.828795136153;4052.1085361220485;4119.814608342692;4145.626893579592;4168.687348448818;4197.349410841324;4037.8990525237105;4138.875833724993;4201.915961680688;4203.432536607519;4237.046664500463 08:03:51 INFO - PROCESS | 30994 | |4;prototype.html;290.9650841898972;296.2992522683852;299.6524032122737;301.98641061152244;304.7561950439648;4762.690425122369;4786.712797232169;4794.424669039711;4814.229723244282;4827.5172482751705;4742.336072949781;4752.621739695493;4763.809447622091;4766.1659209638265;4775.713457192571;3531.781535370293;3655.524781778365;3661.7000964657564;3772.962270377295;3783.6216378362083;3632.6730594246515;3655.5430571178604;3670.541182352206;3753.11801726594;3783.5270591176104;3745.307118183131;3745.8501659933568;3748.868789592365;3752.287065457568;3760.52993375828;3753.9249215015548;3754.436834474837;3778.1499162688174;3779.130799916035;3784.2053168834304;3272.361889431562;3303.4714445688574;3310.337932413527;3321.717653999413;3323.7839540429795;4626.4910859805395;4635.7218566886095;4639.68015992004;4639.744814035227;4640.582347588733;4212.883585849752;4249.617534421917;4279.614834664864;4284.871453856358;4293.785310734451;4790.568848803589;4888.902221955576;4903.8528844134735;4939.851804445872;4981.576565991859;3583.4087375583;3588.784672919633;3589.353916295066;3593.245418462126;3613.2050948791225;5183.429822719498;5193.480651934814;5193.792248310063;5200.141976573861;5215.348081489814;3587.569491660965;3691.446283057563;3713.034611001159;3716.312482190803;3723.31118743028;3719.442083687414;3735.7571757835653;3741.2517496500263;3759.4548790425783;3770.698344132463;4226.302660061117;4233.153369326147;4236.724612900151;4250.319948808237;4288.442502474721;4932.802687892516;4938.950610493921;4951.183054795918;4961.627877909171;4971.65198436106;1253.793124134526;1286.601153642374;1293.8576756556772;1300.9804852927214;1304.523848795202;824.2581676491205;833.4749108061882;838.7903024243939;848.6775025490398;863.7365603490996;3954.9519377365023;3964.841406343714;3982.4623675803396;4254.936175957363;4359.38968544404;5038.546530812245;5088.72012039334;5090.363704536933;5112.616553758483;5118.617973147229;4355.607995280377;4361.825526978949;4372.978135109368;4376;4384.780760961939;2600.9479810403686;2713;2715.4704832557463;2717.9592306115424;2722.747536133401;4733.26634371666;4746.810127594927;4750.691205071659;4770.95229047712;4773.474917759044;5232.816851410258;5261.868453288698;5264.157165269375;5294.7617357219015;5295.682259064469;4610.331501932201;4704.247320428715;4742.12270729923;4768.880777980509;4788.994311194619;5073.365829271341;5098.847034588968;5102.953894451554;5118.797082685492;5121.180611102206;4957.752112394438;4978.4523702393435;5006.674566153189;5030.773615187252;5066.138756411346;4541.863744087683;4743.746720307826;4753.928691069706;4794.760261986817;4805.37530121082;3585.139566503968;3602.9459558106123;3603.7297202710424;3605.9459108112874;3621.4386770050683;5223.2948551945;5254.159334506614;5257.2639830423;5257.947420525746;5260.526552610283;4927.211646136601;4969.602431805519;4994;5035.748212589283;5060.645754797129;4968.093665205895;5037.7733002014265;5041;5046.293518907282;5049.621278404061;4969.3291405659775;4989.276554899592;4997.150484417731;5015.398152221756;5018.44797072329;4839.782209800638;4958.091489425515;4989.750512474435;5013.323201367769;5091.243520985254;4655.766221951118;4726.480087190475;4775.5167312996355;4849.903001939871;4876.951905059338 08:03:51 INFO - PROCESS | 30994 | |5;yui.html;564.6245246910804;582.5543459253669;596.296370283066;639.2967735490961;716.7204790131849;11250.662480125598;12061.276323420601;12064.396780161002;12071.275723456576;12077.577284795034;10861.565537378496;11202.215844890861;11297.830532542019;11476.942615286913;11533.884661153386;770.4606775257314;783.1150799596477;791.778302075417;792.3898598079476;792.6868886789715;785.7053604898164;789.8104454930804;790.1703211627796;790.3992965346321;790.4940837863771;806.4999700185864;809.3969992355703;810;810.2748040503745;810.3112354498688;805.1023109233221;805.5247404031591;805.7018903005867;805.963731632078;806.1817255485687;599.8740264544451;600.8467840700637;601.380578004656;601.4947444146894;601.9578629495937;10011.79976400468;10062.899371006342;10098.29311948164;10813.729656758644;11072.114230861593;10366.481675916173;10483.633072842415;10519.47402629873;10582.365058096462;11262.21164518484;9263.120003599648;9283.953580232122;9295.16343529079;9456.05439456049;9566.856497152548;3018.5773991641186;3122.9219269518217;3134.2164458885277;3136.827474488902;3316.4196265653654;46893.29660055102;47736.28395574069;48315.27527087097;48499.515004849854;49999.75000124976;7693.846123077507;7700.807479813049;7746.806329841799;7859.056913170456;7964.402669799672;15679;15727.292271847795;15731.606709832116;15764.68470630581;15881.364745410054;6697.196336439659;6759.932400676029;6763.7632682855865;6797.490188235902;7019.4384449243935;3656.963430365662;3661.359262129117;3682.779033258013;3708.0915175782106;3783.981080094582;2637.7494138056854;2729.6042073899175;2742.780577553791;2745.1215611004286;2748.573971034493;452.57684065398956;463.8214287499337;472.65968502678703;476.24752890433035;477;590.5806877117295;604.3774911840811;609.607534072883;617.6818938246806;639.3287048598952;7193.820154496179;7417.59203243816;7735;7791.6883324667515;7962.2037796221075;455.9954400455953;585.4661972388128;595.8986972214734;597.0536699331608;615.8244900203421;3860.7876566788536;3881.8059097045034;3925.5878132795647;4029.9597004029583;4181.477315335583;66356.33643663501;67262.66368668224;68739.3126068733;69787.65106174538;70022;39293;39355.40966885499;40378;54471.182932256044;62535.37464625386;56594.15108773372;56819;57206.7139664299;57350.13974790381;57574.71212643994;7377.3360397564475;7751.379889608705;7826.178251283533;7870.331021863206;8059.476134051268;37795;38508.42237366498;38525;38831.223375531765;39704.404433932934;30995.535066973564;31572.842135789175;43161;51339.743301283255;51457.742711286206;9210.539473026189;9609.183219426428;9669.371490853073;9726.854097188689;10007.349522281029;10615.256932014994;10726.302790318605;10752.139828813833;10805.405702686428;10839.512221949873;9116;9372.753370254346;9579.664711735057;10052.095311422006;10056.19550435978;9433.52832358393;9736;9763.799922296075;9864.358816676893;10006.69979900604;9453.716388508356;9586.328956973224;9950.115404660744;10018.849717254392;10158.339707918962;8826.867596985921;9103.772405689911;9191.126842949909;9194.12655797698;9390;8542.572871356531;8726.69456569017;9142.680006199751;9256.213221876216;9273.582688779155 08:03:51 INFO - PROCESS | 30994 | __end_tp_report 08:03:51 INFO - PROCESS | 30994 | __start_cc_report 08:03:51 INFO - PROCESS | 30994 | _x_x_mozilla_cycle_collect,1265 08:03:51 INFO - PROCESS | 30994 | __end_cc_report 08:03:51 INFO - PROCESS | 30994 | __startTimestamp1477753431971__endTimestamp 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | ------- Summary: start ------- 08:03:51 INFO - PROCESS | 30994 | Number of tests: 6 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | [#0] dojo.html Cycles:165 Average:4464.38 Median:4551.89 stddev:472.34 (10.4%) stddev-sans-first:446.53 08:03:51 INFO - PROCESS | 30994 | Values: 2448.6 2454.0 2481.0 2496.1 2499.0 4401.5 4447.7 4490.1 4492.2 4503.0 4475.9 4484.0 4498.4 4502.8 4551.8 4082.8 4086.9 4129.3 4140.2 4172.7 3823.8 4170.0 4188.9 4202.9 4246.4 4233.5 4278.1 4279.7 4306.7 4336.1 4073.6 4107.8 4112.9 4153.5 4159.4 4096.1 4112.3 4122.1 4135.9 4184.1 4473.6 4480.2 4482.7 4511.4 4551.9 4713.7 4796.1 4797.8 4810.9 4855.3 4777.5 4827.1 4839.3 4842.4 4858.7 4520.5 4528.3 4532.5 4534.0 4598.1 4952.6 4958.7 5013.1 5014.1 5017.6 4728.1 4730.7 4742.1 4743.0 4796.1 4678.9 4767.5 4827.9 4829.6 4853.5 4672.2 4743.3 4748.6 4754.4 4782.4 4711.4 4722.9 4734.2 4745.7 4845.1 4177.8 4186.7 4201.1 4225.7 4245.8 3557.5 3572.6 3621.5 3624.0 3666.2 4109.5 4153.3 4154.5 4154.7 4164.9 4797.7 4838.9 4842.3 4845.4 4884.7 4072.6 4112.6 4145.8 4147.6 4157.2 4350.9 4384.1 4399.3 4407.4 4471.0 4509.3 4513.7 4534.5 4569.0 4570.1 4841.6 4857.6 4858.5 4862.2 4926.8 4385.3 4425.0 4428.0 4509.8 4521.1 4747.1 4794.8 4803.4 4813.6 4889.0 4879.5 4885.7 4895.1 4901.0 4957.4 4646.6 4719.5 4754.0 4760.0 4820.1 4668.2 4686.7 4712.2 4755.2 4764.5 4630.9 4631.6 4678.7 4705.3 4710.3 4734.4 4734.8 4741.5 4741.9 4798.9 4482.1 4613.2 4616.5 4676.0 4678.8 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | [#1] ext.html Cycles:180 Average:45037.48 Median:202236.54 stddev:76460.74 (37.8%) stddev-sans-first:76602.27 08:03:51 INFO - PROCESS | 30994 | Values: 550.1 552.5 552.9 562.4 574.8 28372.6 39900.2 41556.0 41675.2 45340.5 42125.0 42666.8 42669.0 42687.1 42746.8 7752.7 7889.5 7904.4 7907.3 7908.0 7790.3 7877.3 7894.5 7899.9 7914.1 7776.5 7837.3 7898.6 7901.4 7909.1 7782.7 7811.7 7829.8 7836.7 7874.4 7694.9 7749.2 7755.9 7756.8 7757.9 39068.0 39407.0 39485.4 39487.2 39523.6 2868.2 2987.8 3411.6 3464.8 3474.6 26554.7 29227.6 29503.7 29520.6 29537.4 3471.0 3535.2 3581.2 3610.6 3673.0 238532.0 240143.0 242522.0 242665.8 243554.0 55020.0 55276.7 55312.4 55341.7 55381.0 59218.0 59237.4 59309.7 59311.4 59374.1 15314.3 15565.8 15575.5 15584.5 15594.6 11822.6 11872.6 11890.8 11892.7 11898.8 17892.4 18335.9 18360.2 18489.0 18552.4 6664.8 6804.3 6897.5 6926.7 7189.1 732.0 914.7 916.0 953.9 976.3 27213.7 27483.2 28216.3 28368.7 28587.4 762.7 944.9 954.8 977.9 983.1 13765.8 14639.9 14645.0 14790.9 14830.1 366257.0 366409.0 367286.0 367665.0 368265.1 50491.7 50841.2 50932.2 50949.2 50970.7 1156.9 1186.1 1188.6 1193.4 1212.3 25589.7 26609.6 26744.5 27482.0 27603.0 42207.8 42662.1 42781.0 42807.4 42855.0 246682.0 247716.0 247862.0 247960.0 249587.0 25069.2 25861.4 25900.3 25906.6 26059.5 42120.8 42614.1 42642.8 42680.8 43845.8 35595.3 36102.8 36296.3 36551.0 36808.1 36029.1 36399.0 36643.3 36648.5 36940.4 30680.5 31463.7 35595.8 36094.5 37007.0 29224.1 31947.2 33656.9 36380.5 36963.6 24979.6 25784.5 25951.9 25992.7 26337.6 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | [#2] jquery.html Cycles:180 Average:23841.40 Median:50374.00 stddev:63789.89 (126.6%) stddev-sans-first:63944.46 08:03:51 INFO - PROCESS | 30994 | Values: 355.5 355.6 365.1 368.7 386.5 15746.4 16904.8 17714.3 17777.4 17847.2 16441.8 16636.7 17285.3 17287.5 17393.3 4817.9 5117.1 5119.1 5119.7 5122.5 3634.2 3815.0 5004.6 5734.3 6047.9 6006.5 6007.5 6018.0 6027.7 6028.8 5669.8 5849.1 5858.0 5869.5 5872.1 4996.0 5136.9 5140.8 5144.6 5145.3 20473.9 20885.0 20955.0 21037.2 21050.4 1779.5 1803.2 1807.3 1835.4 1886.7 12173.6 12970.6 13273.0 13367.4 13505.9 1627.8 1678.5 1716.7 1733.9 1779.0 68412.7 71200.0 71839.0 72905.0 74110.6 9216.3 9374.5 9375.4 9419.5 9430.7 12764.2 12773.2 12830.3 12852.1 12859.4 7240.6 7260.3 7362.3 7433.3 7538.1 7011.4 7075.8 7178.1 7240.8 7241.4 5145.8 5521.3 5561.8 5823.9 5963.9 1624.3 1651.2 1751.4 1762.0 1764.1 846.3 876.6 902.7 932.6 942.6 15828.4 16648.1 17748.3 18646.4 19073.0 844.5 847.5 852.8 856.0 868.3 6891.4 9762.2 9856.5 9922.1 9981.9 377704.0 378774.0 394511.0 394780.0 394826.0 47598.3 47948.8 47955.5 65509.3 72190.0 921.9 923.3 935.5 941.8 944.3 15088.5 15210.5 15757.2 15924.3 16056.6 33878.5 34874.5 36487.5 37741.2 41220.4 50322.5 50425.5 51717.0 51941.0 52472.7 6887.6 7084.4 7474.6 7564.5 7572.4 9906.7 10991.4 11189.4 11442.4 11537.4 9322.0 9531.3 10098.8 10218.5 10545.9 9580.9 9641.0 9668.9 9874.6 10019.7 10087.8 10123.0 10137.8 10211.5 10700.9 7398.2 7414.3 7444.4 7609.0 7797.7 9757.4 10012.1 10029.1 10354.9 10488.1 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | [#3] mootools.html Cycles:180 Average:4459.48 Median:5480.30 stddev:2324.32 (42.4%) stddev-sans-first:2318.76 08:03:51 INFO - PROCESS | 30994 | Values: 1306.8 1351.1 1353.8 1588.7 1644.8 5943.6 6136.0 6370.0 6747.8 6752.6 6389.1 6613.6 6640.7 6806.9 6811.8 2086.1 2111.9 2113.3 2113.5 2115.9 1801.0 2055.2 2100.5 2110.7 2124.8 1793.0 2009.4 2071.9 2083.2 2091.4 1986.3 1990.0 1995.4 2000.7 2002.8 2061.1 2072.8 2076.7 2079.1 2082.2 6652.5 6723.5 6728.8 6733.4 6758.4 4144.1 4283.9 4285.4 4291.4 4292.9 2493.5 2654.5 2664.5 2672.3 2672.7 779.7 820.0 826.3 834.9 835.5 8791.7 8807.1 8844.0 8848.2 8861.0 3770.8 3865.7 3950.0 3957.2 3977.9 7518.4 7522.5 7523.7 7547.2 7551.9 4221.9 4302.7 4308.3 4316.9 4319.5 3824.0 3892.3 3900.0 3900.1 3900.7 3262.4 3290.3 3357.9 3374.4 3420.1 1000.3 1044.7 1046.7 1056.4 1061.8 689.4 703.5 743.7 772.5 783.5 4526.7 4584.2 4601.4 4642.7 4659.9 824.8 827.4 828.3 832.6 848.4 3055.3 3126.8 3138.6 3185.3 3251.7 7461.0 7823.8 7849.4 7858.6 7868.5 7812.1 7819.7 7821.0 7823.3 7830.3 6159.8 6243.7 6244.7 6246.9 6248.5 4334.7 4487.5 4508.6 4574.4 4636.6 7056.6 7069.6 7111.1 7143.5 7186.4 7199.6 7238.1 7274.2 7325.3 7453.4 6369.8 6404.8 6408.6 6500.4 6511.2 6328.8 6424.6 6438.3 6438.7 6446.1 5863.9 5956.5 5974.7 5982.0 5985.8 5759.3 5761.2 5762.7 5789.6 5922.2 5405.5 5555.1 5591.2 5704.4 5706.8 4052.1 4119.8 4145.6 4168.7 4197.3 4037.9 4138.9 4201.9 4203.4 4237.0 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | [#4] prototype.html Cycles:180 Average:4135.91 Median:4737.69 stddev:1197.14 (25.3%) stddev-sans-first:1165.19 08:03:51 INFO - PROCESS | 30994 | Values: 291.0 296.3 299.7 302.0 304.8 4762.7 4786.7 4794.4 4814.2 4827.5 4742.3 4752.6 4763.8 4766.2 4775.7 3531.8 3655.5 3661.7 3773.0 3783.6 3632.7 3655.5 3670.5 3753.1 3783.5 3745.3 3745.9 3748.9 3752.3 3760.5 3753.9 3754.4 3778.1 3779.1 3784.2 3272.4 3303.5 3310.3 3321.7 3323.8 4626.5 4635.7 4639.7 4639.7 4640.6 4212.9 4249.6 4279.6 4284.9 4293.8 4790.6 4888.9 4903.9 4939.9 4981.6 3583.4 3588.8 3589.4 3593.2 3613.2 5183.4 5193.5 5193.8 5200.1 5215.3 3587.6 3691.4 3713.0 3716.3 3723.3 3719.4 3735.8 3741.3 3759.5 3770.7 4226.3 4233.2 4236.7 4250.3 4288.4 4932.8 4939.0 4951.2 4961.6 4971.7 1253.8 1286.6 1293.9 1301.0 1304.5 824.3 833.5 838.8 848.7 863.7 3955.0 3964.8 3982.5 4254.9 4359.4 5038.5 5088.7 5090.4 5112.6 5118.6 4355.6 4361.8 4373.0 4376.0 4384.8 2600.9 2713.0 2715.5 2718.0 2722.7 4733.3 4746.8 4750.7 4771.0 4773.5 5232.8 5261.9 5264.2 5294.8 5295.7 4610.3 4704.2 4742.1 4768.9 4789.0 5073.4 5098.8 5103.0 5118.8 5121.2 4957.8 4978.5 5006.7 5030.8 5066.1 4541.9 4743.7 4753.9 4794.8 4805.4 3585.1 3602.9 3603.7 3605.9 3621.4 5223.3 5254.2 5257.3 5257.9 5260.5 4927.2 4969.6 4994.0 5035.7 5060.6 4968.1 5037.8 5041.0 5046.3 5049.6 4969.3 4989.3 4997.2 5015.4 5018.4 4839.8 4958.1 4989.8 5013.3 5091.2 4655.8 4726.5 4775.5 4849.9 4877.0 08:03:51 INFO - PROCESS | 30994 | 08:03:51 INFO - PROCESS | 30994 | [#5] yui.html Cycles:180 Average:13559.24 Median:596.10 stddev:17576.60 (2948.6%) stddev-sans-first:17598.82 08:03:51 INFO - PROCESS | 30994 | Values: 564.6 582.6 596.3 639.3 716.7 11250.7 12061.3 12064.4 12071.3 12077.6 10861.6 11202.2 11297.8 11476.9 11533.9 770.5 783.1 791.8 792.4 792.7 785.7 789.8 790.2 790.4 790.5 806.5 809.4 810.0 810.3 810.3 805.1 805.5 805.7 806.0 806.2 599.9 600.8 601.4 601.5 602.0 10011.8 10062.9 10098.3 10813.7 11072.1 10366.5 10483.6 10519.5 10582.4 11262.2 9263.1 9284.0 9295.2 9456.1 9566.9 3018.6 3122.9 3134.2 3136.8 3316.4 46893.3 47736.3 48315.3 48499.5 49999.8 7693.8 7700.8 7746.8 7859.1 7964.4 15679.0 15727.3 15731.6 15764.7 15881.4 6697.2 6759.9 6763.8 6797.5 7019.4 3657.0 3661.4 3682.8 3708.1 3784.0 2637.7 2729.6 2742.8 2745.1 2748.6 452.6 463.8 472.7 476.2 477.0 590.6 604.4 609.6 617.7 639.3 7193.8 7417.6 7735.0 7791.7 7962.2 456.0 585.5 595.9 597.1 615.8 3860.8 3881.8 3925.6 4030.0 4181.5 66356.3 67262.7 68739.3 69787.7 70022.0 39293.0 39355.4 40378.0 54471.2 62535.4 56594.2 56819.0 57206.7 57350.1 57574.7 7377.3 7751.4 7826.2 7870.3 8059.5 37795.0 38508.4 38525.0 38831.2 39704.4 30995.5 31572.8 43161.0 51339.7 51457.7 9210.5 9609.2 9669.4 9726.9 10007.3 10615.3 10726.3 10752.1 10805.4 10839.5 9116.0 9372.8 9579.7 10052.1 10056.2 9433.5 9736.0 9763.8 9864.4 10006.7 9453.7 9586.3 9950.1 10018.8 10158.3 8826.9 9103.8 9191.1 9194.1 9390.0 8542.6 8726.7 9142.7 9256.2 9273.6 08:03:51 INFO - PROCESS | 30994 | -------- Summary: end -------- 08:03:51 INFO - PROCESS | 30994 | 08:03:52 INFO - TEST-INFO | 30994: exit 0 08:03:52 INFO - TEST-OK | dromaeo_css | took 1120433ms 08:03:52 INFO - TEST-START | kraken 08:03:52 INFO - operating with platform_type : linux_ 08:03:52 INFO - Initialising browser for kraken test... 08:03:52 INFO - TEST-INFO | started process 31298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmd1NH/profile http://localhost:60210/getInfo.html) 08:03:56 INFO - PROCESS | 31298 | __metrics Screen width/height:1600/1200 08:03:56 INFO - PROCESS | 31298 | colorDepth:24 08:03:56 INFO - PROCESS | 31298 | Browser inner width/height: 1024/697 08:03:56 INFO - PROCESS | 31298 | __metrics 08:03:57 INFO - PROCESS | 31298 | 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" 08:03:57 INFO - PROCESS | 31298 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:03:58 INFO - TEST-INFO | 31298: exit 0 08:03:58 INFO - Browser initialized. 08:03:58 INFO - Running cycle 1/1 for kraken test... 08:03:58 INFO - TEST-INFO | started process 31382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmd1NH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:10 INFO - PROCESS | 31382 | RSS: Main: 175906816 08:04:10 INFO - PROCESS | 31382 | 08:04:13 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60210/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:14 INFO - PROCESS | 31382 | RSS: Main: 241225728 08:04:14 INFO - PROCESS | 31382 | 08:04:17 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60210/tests/kraken/driver.html?testName=audio-dft) 08:04:18 INFO - PROCESS | 31382 | RSS: Main: 219426816 08:04:18 INFO - PROCESS | 31382 | 08:04:21 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60210/tests/kraken/driver.html?testName=audio-fft) 08:04:22 INFO - PROCESS | 31382 | RSS: Main: 302346240 08:04:22 INFO - PROCESS | 31382 | 08:04:24 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60210/tests/kraken/driver.html?testName=audio-oscillator) 08:04:24 INFO - PROCESS | 31382 | RSS: Main: 212287488 08:04:24 INFO - PROCESS | 31382 | 08:04:27 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:27 INFO - PROCESS | 31382 | RSS: Main: 215052288 08:04:27 INFO - PROCESS | 31382 | 08:04:30 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60210/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:31 INFO - PROCESS | 31382 | RSS: Main: 250613760 08:04:31 INFO - PROCESS | 31382 | 08:04:34 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60210/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:35 INFO - PROCESS | 31382 | RSS: Main: 250331136 08:04:35 INFO - PROCESS | 31382 | 08:04:38 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60210/tests/kraken/driver.html?testName=json-parse-financial) 08:04:38 INFO - PROCESS | 31382 | RSS: Main: 250089472 08:04:38 INFO - PROCESS | 31382 | 08:04:40 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:41 INFO - PROCESS | 31382 | RSS: Main: 212856832 08:04:41 INFO - PROCESS | 31382 | 08:04:43 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:43 INFO - PROCESS | 31382 | RSS: Main: 220274688 08:04:43 INFO - PROCESS | 31382 | 08:04:45 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:46 INFO - PROCESS | 31382 | RSS: Main: 228769792 08:04:46 INFO - PROCESS | 31382 | 08:04:49 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:50 INFO - PROCESS | 31382 | RSS: Main: 236752896 08:04:50 INFO - PROCESS | 31382 | 08:04:52 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:53 INFO - PROCESS | 31382 | RSS: Main: 234332160 08:04:53 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | Cycle 1(1): loaded http://localhost:60210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60210/tests/kraken/driver.html?testName=ai-astar) 08:04:55 INFO - PROCESS | 31382 | RSS: Main: 284315648 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | __start_tp_report 08:04:55 INFO - PROCESS | 31382 | _x_x_mozilla_page_load 08:04:55 INFO - PROCESS | 31382 | _x_x_mozilla_page_load_details 08:04:55 INFO - PROCESS | 31382 | |i|pagename|runs| 08:04:55 INFO - PROCESS | 31382 | |0;ai-astar;107;116;115;115;115;116;115;117;116;118 08:04:55 INFO - PROCESS | 31382 | |1;audio-beat-detection;155;128;130;179;133;127;126;127;169;127 08:04:55 INFO - PROCESS | 31382 | |2;audio-dft;171;163;163;163;162;161;163;161;160;160 08:04:55 INFO - PROCESS | 31382 | |3;audio-fft;75;75;76;109;75;77;76;75;100;75 08:04:55 INFO - PROCESS | 31382 | |4;audio-oscillator;83;82;129;83;83;83;105;82;83;120 08:04:55 INFO - PROCESS | 31382 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;118;116 08:04:55 INFO - PROCESS | 31382 | |6;imaging-darkroom;147;146;146;147;146;146;147;146;147;147 08:04:55 INFO - PROCESS | 31382 | |7;imaging-desaturate;85;84;84;84;84;84;84;85;84;85 08:04:55 INFO - PROCESS | 31382 | |8;json-parse-financial;61;61;62;62;62;62;62;62;63;63 08:04:55 INFO - PROCESS | 31382 | |9;json-stringify-tinderbox;66;66;66;67;67;67;67;66;67;66 08:04:55 INFO - PROCESS | 31382 | |10;stanford-crypto-aes;84;84;83;83;84;83;83;84;82;83 08:04:55 INFO - PROCESS | 31382 | |11;stanford-crypto-ccm;144;144;140;150;140;142;138;140;182;141 08:04:55 INFO - PROCESS | 31382 | |12;stanford-crypto-pbkdf2;180;192;180;173;178;175;173;178;173;171 08:04:55 INFO - PROCESS | 31382 | |13;stanford-crypto-sha256-iterative;69;70;69;69;69;68;67;68;70;67 08:04:55 INFO - PROCESS | 31382 | __end_tp_report 08:04:55 INFO - PROCESS | 31382 | __start_cc_report 08:04:55 INFO - PROCESS | 31382 | _x_x_mozilla_cycle_collect,1935 08:04:55 INFO - PROCESS | 31382 | __end_cc_report 08:04:55 INFO - PROCESS | 31382 | __startTimestamp1477753495603__endTimestamp 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | ------- Summary: start ------- 08:04:55 INFO - PROCESS | 31382 | Number of tests: 14 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#0] ai-astar Cycles:10 Average:115.00 Median:116.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 08:04:55 INFO - PROCESS | 31382 | Values: 107.0 116.0 115.0 115.0 115.0 116.0 115.0 117.0 116.0 118.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:131.50 stddev:19.95 (15.2%) stddev-sans-first:20.42 08:04:55 INFO - PROCESS | 31382 | Values: 155.0 128.0 130.0 179.0 133.0 127.0 126.0 127.0 169.0 127.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:3.16 (1.9%) stddev-sans-first:1.30 08:04:55 INFO - PROCESS | 31382 | Values: 171.0 163.0 163.0 163.0 162.0 161.0 163.0 161.0 160.0 160.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:12.43 (16.6%) stddev-sans-first:12.97 08:04:55 INFO - PROCESS | 31382 | Values: 75.0 75.0 76.0 109.0 75.0 77.0 76.0 75.0 100.0 75.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:17.98 (21.7%) stddev-sans-first:18.68 08:04:55 INFO - PROCESS | 31382 | Values: 83.0 82.0 129.0 83.0 83.0 83.0 105.0 82.0 83.0 120.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:04:55 INFO - PROCESS | 31382 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 116.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:04:55 INFO - PROCESS | 31382 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 08:04:55 INFO - PROCESS | 31382 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 08:04:55 INFO - PROCESS | 31382 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:04:55 INFO - PROCESS | 31382 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 08:04:55 INFO - PROCESS | 31382 | Values: 84.0 84.0 83.0 83.0 84.0 83.0 83.0 84.0 82.0 83.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:143.00 stddev:13.05 (9.1%) stddev-sans-first:13.82 08:04:55 INFO - PROCESS | 31382 | Values: 144.0 144.0 140.0 150.0 140.0 142.0 138.0 140.0 182.0 141.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:178.00 stddev:6.07 (3.4%) stddev-sans-first:6.36 08:04:55 INFO - PROCESS | 31382 | Values: 180.0 192.0 180.0 173.0 178.0 175.0 173.0 178.0 173.0 171.0 08:04:55 INFO - PROCESS | 31382 | 08:04:55 INFO - PROCESS | 31382 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 08:04:55 INFO - PROCESS | 31382 | Values: 69.0 70.0 69.0 69.0 69.0 68.0 67.0 68.0 70.0 67.0 08:04:55 INFO - PROCESS | 31382 | -------- Summary: end -------- 08:04:55 INFO - PROCESS | 31382 | 08:04:56 INFO - TEST-INFO | 31382: exit 0 08:04:56 INFO - TEST-OK | kraken | took 64100ms 08:04:56 INFO - SUITE-END | took 1184s 08:04:57 INFO - Completed test suite (00:19:44) 08:04:57 INFO - javascript benchmark 08:04:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2448.620463828105, 2453.98773006135, 2480.9827970532087, 2496.0515004298377, 2499.0, 4401.537838526957, 4447.688661793676, 4490.10197960408, 4492.191405547001, 4503.0318481526465, 4475.865724028285, 4483.991102002048, 4498.437695288089, 4502.842400515982, 4551.772411379435, 4082.7754473503946, 4086.9182616347657, 4129.298019336705, 4140.213359461708, 4172.666186705072, 3823.8279277432443, 4169.9791501042455, 4188.895277618053, 4202.873913782591, 4246.447961764966, 4233.470816147981, 4278.122984788142, 4279.743215407086, 4306.655467562603, 4336.111097225062, 4073.5722749111214, 4107.835686572534, 4112.876613701594, 4153.522344930341, 4159.376093585956, 4096.078382363974, 4112.259793237216, 4122.093139509303, 4135.9172816543805, 4184.14225083857, 4473.575010374042, 4480.215962206634, 4482.731036137842, 4511.4135162429, 4551.886202844922, 4713.740744259065, 4796.136695394827, 4797.784099715521, 4810.903781924377, 4855.271709243606, 4777.546133117348, 4827.08285425768, 4839.27410888366, 4842.370491836039, 4858.732769697665, 4520.547945205486, 4528.343390208402, 4532.546745325441, 4533.977330113361, 4598.103369842848, 4952.603791696728, 4958.677685950402, 5013.072581572421, 5014.0974624567925, 5017.598592112622, 4728.078024785203, 4730.668853180313, 4742.146413645577, 4743.0, 4796.112719146969, 4678.8596342109795, 4767.4994125617, 4827.903441931212, 4829.5653391194255, 4853.49038350968, 4672.182368085571, 4743.312219728189, 4748.596369308648, 4754.405699287589, 4782.378290822171, 4711.411073615798, 4722.929156062662, 4734.171519983989, 4745.691530050535, 4845.079434907357, 4177.811998460076, 4186.665066794649, 4201.117765269267, 4225.66194704429, 4245.80893859777, 3557.519734835764, 3572.6427357264583, 3621.5473065866768, 3623.963760362363, 3666.211764470652, 4109.465769449952, 4153.314703073959, 4154.522229943595, 4154.667626589866, 4164.916701665949, 4797.664163508521, 4838.879028024257, 4842.346283251786, 4845.41854977405, 4884.658073934862, 4072.6131017553284, 4112.568180341081, 4145.813438395279, 4147.598105883864, 4157.210130075276, 4350.934735978963, 4384.101259241847, 4399.252127138394, 4407.427034485497, 4470.977645111753, 4509.34614480905, 4513.68404211702, 4534.523874993144, 4568.977155114336, 4570.108828778356, 4841.636877234151, 4857.587105096107, 4858.5384388483035, 4862.246351815475, 4926.802927882844, 4385.254506733799, 4425.048614547888, 4428.047969686533, 4509.797059132281, 4521.1409832131785, 4747.074320507468, 4794.832180873653, 4803.3995750531185, 4813.614910807057, 4889.0, 4879.536444037811, 4885.658003939832, 4895.143349913679, 4901.044296362318, 4957.380327459067, 4646.62826973848, 4719.52804719539, 4754.025424787979, 4760.000399916056, 4820.084184005028, 4668.206404911241, 4686.742229177428, 4712.175369310426, 4755.2153894607, 4764.547368000034, 4630.907381852411, 4631.560001799824, 4678.719276843401, 4705.270683044134, 4710.29345598163, 4734.384530011076, 4734.810607575659, 4741.525847415231, 4741.905161896674, 4798.904021919472, 4482.103579284091, 4613.2388155953895, 4616.515265897033, 4676.018036212434, 4678.836240731558], "value": 4433.615988655393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.0813641219164, 552.549672017306, 552.8673118451572, 562.4459906991613, 574.8447919061854, 28372.574411383845, 39900.2019959601, 41556.0, 41675.16649667005, 45340.54659453405, 42125.0, 42666.786666066706, 42669.0, 42687.14625707484, 42746.78626606863, 7752.728654497094, 7889.5266284022855, 7904.446688731791, 7907.327877130451, 7907.960460197691, 7790.337821285169, 7877.291043806056, 7894.486858354188, 7899.9210007899765, 7914.050313962332, 7776.53340799551, 7837.294643482085, 7898.6445609947405, 7901.367890568769, 7909.1299957004685, 7782.688692452295, 7811.726589569338, 7829.765107046769, 7836.725714599962, 7874.409419293519, 7694.9230507694765, 7749.186335434811, 7755.922440775576, 7756.767296981099, 7757.922420775776, 39068.0, 39407.0, 39485.40771888424, 39487.21025579472, 39523.60476395228, 2868.153894601098, 2987.760979121665, 3411.573553305837, 3464.7747896386654, 3474.6351633078666, 26554.73445265542, 29227.56158657622, 29503.70496295031, 29520.557191642143, 29537.409251815057, 3471.0, 3535.222251104753, 3581.194231297963, 3610.606466728225, 3673.045008297835, 238532.0, 240143.0, 242522.0, 242665.78667106727, 243554.0, 55020.0, 55276.72361638166, 55312.44687553073, 55341.723291383285, 55381.0, 59218.0, 59237.407625924054, 59309.70345148247, 59311.40688593145, 59374.140680855606, 15314.310856011507, 15565.84434155644, 15575.532734017997, 15584.532464026097, 15594.610134746496, 11822.645320640395, 11872.643820685393, 11890.762184756257, 11892.702682433008, 11898.76202475963, 17892.373766918095, 18335.90832045831, 18360.173792179383, 18489.0, 18552.350667726565, 6664.766733164316, 6804.3195680432555, 6897.517173797886, 6926.67956234657, 7189.130825985281, 731.9743808966767, 914.7301546043933, 915.9908400915906, 953.9427634341823, 976.2531663277598, 27213.727862721516, 27483.17550473489, 28216.29459263535, 28368.71631283661, 28587.42825143527, 762.7254188492138, 944.9480278584743, 954.8042651256476, 977.8679878216492, 983.0759086458849, 13765.793513097311, 14639.853601463848, 14645.048071875293, 14790.852091478948, 14830.110193388431, 366257.0, 366409.0, 367286.0, 367665.0, 368265.06277091906, 50491.74754126279, 50841.23738143931, 50932.236016459785, 50949.235761463606, 50970.74514627403, 1156.8669602995762, 1186.1104171871098, 1188.5839956015498, 1193.4450480526423, 1212.3271584270815, 25589.74410255948, 26609.600855986788, 26744.465110698067, 27482.0, 27603.0, 42207.788961055, 42662.146757065304, 42781.0, 42807.35788963106, 42855.0, 246682.0, 247716.0, 247862.0, 247960.0, 249587.0, 25069.247922562354, 25861.353466163495, 25900.337939170375, 25906.61140082938, 26059.478810424065, 42120.78939605282, 42614.14771704486, 42642.78678606587, 42680.78659606682, 43845.78077109594, 35595.288094237454, 36102.8194859024, 36296.27407451889, 36551.0, 36808.07979800419, 36029.09927251735, 36399.0, 36643.26713465663, 36648.45027324645, 36940.44589331109, 30680.539791902695, 31463.68536314699, 35595.82202088973, 36094.45858312075, 37007.0, 29224.109490437888, 31947.201319966258, 33656.941750485144, 36380.454293185096, 36963.63036369602, 24979.625305620066, 25784.484310314063, 25951.870240648677, 25992.740072599034, 26337.60493592636], "value": 17549.200090476832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.49697178492437, 355.55555555555554, 365.1419164962339, 368.7308264966576, 386.5438782236961, 15746.448874289403, 16904.830951690496, 17714.291428342884, 17777.37779177729, 17847.196876140573, 16441.83558164418, 16636.66726665469, 17285.30858765651, 17287.481375558753, 17393.304267829302, 4817.927731084036, 5117.053345131144, 5119.10415677255, 5119.667221630601, 5122.513361230677, 3634.182308980485, 3815.0, 5004.599632029429, 5734.254546908917, 6047.909281360783, 6006.519478441714, 6007.4593286604195, 6017.969910150443, 6027.72875220614, 6028.788992385267, 5669.773209071632, 5849.122631605272, 5858.0, 5869.530437564985, 5872.148538461942, 4996.0, 5136.922946155811, 5140.820071297524, 5144.639875208737, 5145.30538377318, 20473.89763051175, 20885.0, 20955.0, 21037.158513659437, 21050.368488945354, 1779.5195297269795, 1803.1975770782008, 1807.3132209760338, 1835.4126679462577, 1886.6604011277964, 12173.634790956285, 12970.577985761955, 13273.0, 13367.398467069006, 13505.86494135056, 1627.7726892596831, 1678.5048410718866, 1716.6566686662593, 1733.8612910967092, 1778.97331540027, 68412.6579367105, 71200.0, 71839.0, 72905.0, 74110.62944685297, 9216.308776841764, 9374.500239884757, 9375.437333813245, 9419.529023548796, 9430.746392494715, 12764.234145951272, 12773.23360598367, 12830.29433381173, 12852.100352975389, 12859.421326040163, 7240.637968101574, 7260.293830949722, 7362.263773622595, 7433.293837085468, 7538.057742782153, 7011.439084873198, 7075.82310442243, 7178.066851309401, 7240.818979525554, 7241.42068634508, 5145.794168233228, 5521.309836270466, 5561.805336813273, 5823.854403639943, 5963.880722385528, 1624.2771966474804, 1651.1826645810402, 1751.3799735245102, 1762.0396883698415, 1764.0826770079743, 846.34408333542, 876.5792419638609, 902.697596305245, 932.6222879733718, 942.6276620734772, 15828.44600438979, 16648.08435536033, 17748.29006839738, 18646.44060678182, 19073.0, 844.5186243840951, 847.5338563789891, 852.8422241885271, 856.0497847389393, 868.3010176807604, 6891.414229790524, 9762.219022478184, 9856.45789481571, 9922.107010369102, 9981.900180998096, 377704.0, 378774.0, 394511.0, 394780.0, 394826.0, 47598.28602570964, 47948.7602561985, 47955.520444795104, 65509.34490655032, 72190.0, 921.9170274675312, 923.2752289452748, 935.5135329628555, 941.8351788436996, 944.3473920638882, 15088.471903483325, 15210.502941602017, 15757.212139393214, 15924.257799416897, 16056.591511273402, 33878.491822622185, 34874.47688284627, 36487.45268821023, 37741.24517509689, 41220.38169427401, 50322.49677503324, 50425.49574504208, 51717.0, 51941.0, 52472.737636313104, 6887.621180834902, 7084.397826184832, 7474.551526908403, 7564.546127232384, 7572.356349710116, 9906.653267135616, 10991.395473249047, 11189.440527973406, 11442.37066961325, 11537.365444900612, 9322.0, 9531.332806703464, 10098.798024039625, 10218.489075546342, 10545.9472702636, 9580.856287155559, 9641.0, 9668.854967175357, 9874.55564499585, 10019.749506262402, 10087.798244034931, 10123.0, 10137.79724405493, 10211.540480678239, 10700.892991070301, 7398.223186565333, 7414.295641914009, 7444.404447644067, 7609.0, 7797.727079552188, 9757.414555126716, 10012.098911098035, 10029.092251880158, 10354.896451035393, 10488.108510776365], "value": 8204.790333971929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.8039794030897, 1351.0812647399766, 1353.776626856568, 1588.7378582533881, 1644.8355164483553, 5943.643381397108, 6135.969320153393, 6369.968150159249, 6747.79756607302, 6752.628605426699, 6389.137466442029, 6613.603183808975, 6640.734370625181, 6806.863862722743, 6811.761588344409, 2086.061272427406, 2111.862728922623, 2113.260358874397, 2113.5350222950924, 2115.947101322464, 1801.0364455016568, 2055.239561362298, 2100.5063810004635, 2110.67284570891, 2124.75565309989, 1792.9910350448295, 2009.3971808457477, 2071.85497015209, 2083.208380815288, 2091.4144039668918, 1986.3147214211074, 1990.0348331059424, 1995.4013795861183, 2000.679891217413, 2002.819746222847, 2061.134323584098, 2072.7927207279304, 2076.709260703503, 2079.07481170879, 2082.2295750572234, 6652.467802575782, 6723.495737819634, 6728.83177920551, 6733.4276586490205, 6758.391744742997, 4144.088300573869, 4283.892902677427, 4285.3786201000685, 4291.377750226231, 4292.9141417171795, 2493.463905260378, 2654.5089158505543, 2664.5203863304596, 2672.2918426616766, 2672.692640346366, 779.6881247500988, 820.024171236233, 826.3100311240122, 834.9081601023883, 835.5195762436623, 8791.736247912573, 8807.119288071206, 8844.027157012788, 8848.159424854628, 8861.025287218401, 3770.7549009314307, 3865.6714179294513, 3949.9802500987885, 3957.2085582883537, 3977.940330895039, 7518.436117291225, 7522.473426860177, 7523.7366692165515, 7547.245275472519, 7551.886721699179, 4221.915561688749, 4302.677299202573, 4308.267594508941, 4316.913661726748, 4319.524852266248, 3823.9808800955816, 3892.2993861104706, 3899.9610003900166, 3900.1419687668667, 3900.7269491135917, 3262.363839051362, 3290.276139249361, 3357.9496307555405, 3374.4432168692383, 3420.1449637590604, 1000.2598077422655, 1044.738815296176, 1046.7330830638139, 1056.4031322303028, 1061.7929503746695, 689.441552342604, 703.5356664601441, 743.6616339565485, 772.5094564951296, 783.5103060587134, 4526.683132180716, 4584.1977653910435, 4601.44782626087, 4642.72143671374, 4659.906801863944, 824.8226631274305, 827.3877330775183, 828.2628460670009, 832.5587438657521, 848.3637272045966, 3055.3431012332453, 3126.812391256532, 3138.6076740407448, 3185.2514659055105, 3251.650799676337, 7461.0, 7823.765287041398, 7849.411294152847, 7858.567778772108, 7868.488548244346, 7812.062552493623, 7819.687212511436, 7820.960895195602, 7823.256790604997, 7830.334421574116, 6159.84600384994, 6243.687815609202, 6244.65654389013, 6246.906296405557, 6248.4688801452385, 4334.674899382622, 4487.461504619467, 4508.616767574662, 4574.428196475441, 4636.582707556201, 7056.611886346095, 7069.6111713856235, 7111.075560177143, 7143.535670181422, 7186.425085993003, 7199.568025918462, 7238.0952380952385, 7274.236205198378, 7325.267473252632, 7453.440991925736, 6369.840753981188, 6404.775832845828, 6408.647524386017, 6500.447461965786, 6511.218653761579, 6328.778492752916, 6424.614523128627, 6438.259600146043, 6438.67806609677, 6446.0975463434215, 5863.882722345615, 5956.463918247378, 5974.731137098754, 5981.970090149522, 5985.820425387245, 5759.308882934075, 5761.164631128379, 5762.711864406847, 5789.623674461147, 5922.230110085661, 5405.5135037846785, 5555.0834112371, 5591.161325801162, 5704.372519022987, 5706.828795136153, 4052.1085361220485, 4119.814608342692, 4145.626893579592, 4168.687348448818, 4197.349410841324, 4037.8990525237105, 4138.875833724993, 4201.915961680688, 4203.432536607519, 4237.046664500463], "value": 3674.7820214461417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.9650841898972, 296.2992522683852, 299.6524032122737, 301.98641061152244, 304.7561950439648, 4762.690425122369, 4786.712797232169, 4794.424669039711, 4814.229723244282, 4827.5172482751705, 4742.336072949781, 4752.621739695493, 4763.809447622091, 4766.1659209638265, 4775.713457192571, 3531.781535370293, 3655.524781778365, 3661.7000964657564, 3772.962270377295, 3783.6216378362083, 3632.6730594246515, 3655.5430571178604, 3670.541182352206, 3753.11801726594, 3783.5270591176104, 3745.307118183131, 3745.8501659933568, 3748.868789592365, 3752.287065457568, 3760.52993375828, 3753.9249215015548, 3754.436834474837, 3778.1499162688174, 3779.130799916035, 3784.2053168834304, 3272.361889431562, 3303.4714445688574, 3310.337932413527, 3321.717653999413, 3323.7839540429795, 4626.4910859805395, 4635.7218566886095, 4639.68015992004, 4639.744814035227, 4640.582347588733, 4212.883585849752, 4249.617534421917, 4279.614834664864, 4284.871453856358, 4293.785310734451, 4790.568848803589, 4888.902221955576, 4903.8528844134735, 4939.851804445872, 4981.576565991859, 3583.4087375583, 3588.784672919633, 3589.353916295066, 3593.245418462126, 3613.2050948791225, 5183.429822719498, 5193.480651934814, 5193.792248310063, 5200.141976573861, 5215.348081489814, 3587.569491660965, 3691.446283057563, 3713.034611001159, 3716.312482190803, 3723.31118743028, 3719.442083687414, 3735.7571757835653, 3741.2517496500263, 3759.4548790425783, 3770.698344132463, 4226.302660061117, 4233.153369326147, 4236.724612900151, 4250.319948808237, 4288.442502474721, 4932.802687892516, 4938.950610493921, 4951.183054795918, 4961.627877909171, 4971.65198436106, 1253.793124134526, 1286.601153642374, 1293.8576756556772, 1300.9804852927214, 1304.523848795202, 824.2581676491205, 833.4749108061882, 838.7903024243939, 848.6775025490398, 863.7365603490996, 3954.9519377365023, 3964.841406343714, 3982.4623675803396, 4254.936175957363, 4359.38968544404, 5038.546530812245, 5088.72012039334, 5090.363704536933, 5112.616553758483, 5118.617973147229, 4355.607995280377, 4361.825526978949, 4372.978135109368, 4376.0, 4384.780760961939, 2600.9479810403686, 2713.0, 2715.4704832557463, 2717.9592306115424, 2722.747536133401, 4733.26634371666, 4746.810127594927, 4750.691205071659, 4770.95229047712, 4773.474917759044, 5232.816851410258, 5261.868453288698, 5264.157165269375, 5294.7617357219015, 5295.682259064469, 4610.331501932201, 4704.247320428715, 4742.12270729923, 4768.880777980509, 4788.994311194619, 5073.365829271341, 5098.847034588968, 5102.953894451554, 5118.797082685492, 5121.180611102206, 4957.752112394438, 4978.4523702393435, 5006.674566153189, 5030.773615187252, 5066.138756411346, 4541.863744087683, 4743.746720307826, 4753.928691069706, 4794.760261986817, 4805.37530121082, 3585.139566503968, 3602.9459558106123, 3603.7297202710424, 3605.9459108112874, 3621.4386770050683, 5223.2948551945, 5254.159334506614, 5257.2639830423, 5257.947420525746, 5260.526552610283, 4927.211646136601, 4969.602431805519, 4994.0, 5035.748212589283, 5060.645754797129, 4968.093665205895, 5037.7733002014265, 5041.0, 5046.293518907282, 5049.621278404061, 4969.3291405659775, 4989.276554899592, 4997.150484417731, 5015.398152221756, 5018.44797072329, 4839.782209800638, 4958.091489425515, 4989.750512474435, 5013.323201367769, 5091.243520985254, 4655.766221951118, 4726.480087190475, 4775.5167312996355, 4849.903001939871, 4876.951905059338], "value": 3756.7006305529662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6245246910804, 582.5543459253669, 596.296370283066, 639.2967735490961, 716.7204790131849, 11250.662480125598, 12061.276323420601, 12064.396780161002, 12071.275723456576, 12077.577284795034, 10861.565537378496, 11202.215844890861, 11297.830532542019, 11476.942615286913, 11533.884661153386, 770.4606775257314, 783.1150799596477, 791.778302075417, 792.3898598079476, 792.6868886789715, 785.7053604898164, 789.8104454930804, 790.1703211627796, 790.3992965346321, 790.4940837863771, 806.4999700185864, 809.3969992355703, 810.0, 810.2748040503745, 810.3112354498688, 805.1023109233221, 805.5247404031591, 805.7018903005867, 805.963731632078, 806.1817255485687, 599.8740264544451, 600.8467840700637, 601.380578004656, 601.4947444146894, 601.9578629495937, 10011.79976400468, 10062.899371006342, 10098.29311948164, 10813.729656758644, 11072.114230861593, 10366.481675916173, 10483.633072842415, 10519.47402629873, 10582.365058096462, 11262.21164518484, 9263.120003599648, 9283.953580232122, 9295.16343529079, 9456.05439456049, 9566.856497152548, 3018.5773991641186, 3122.9219269518217, 3134.2164458885277, 3136.827474488902, 3316.4196265653654, 46893.29660055102, 47736.28395574069, 48315.27527087097, 48499.515004849854, 49999.75000124976, 7693.846123077507, 7700.807479813049, 7746.806329841799, 7859.056913170456, 7964.402669799672, 15679.0, 15727.292271847795, 15731.606709832116, 15764.68470630581, 15881.364745410054, 6697.196336439659, 6759.932400676029, 6763.7632682855865, 6797.490188235902, 7019.4384449243935, 3656.963430365662, 3661.359262129117, 3682.779033258013, 3708.0915175782106, 3783.981080094582, 2637.7494138056854, 2729.6042073899175, 2742.780577553791, 2745.1215611004286, 2748.573971034493, 452.57684065398956, 463.8214287499337, 472.65968502678703, 476.24752890433035, 477.0, 590.5806877117295, 604.3774911840811, 609.607534072883, 617.6818938246806, 639.3287048598952, 7193.820154496179, 7417.59203243816, 7735.0, 7791.6883324667515, 7962.2037796221075, 455.9954400455953, 585.4661972388128, 595.8986972214734, 597.0536699331608, 615.8244900203421, 3860.7876566788536, 3881.8059097045034, 3925.5878132795647, 4029.9597004029583, 4181.477315335583, 66356.33643663501, 67262.66368668224, 68739.3126068733, 69787.65106174538, 70022.0, 39293.0, 39355.40966885499, 40378.0, 54471.182932256044, 62535.37464625386, 56594.15108773372, 56819.0, 57206.7139664299, 57350.13974790381, 57574.71212643994, 7377.3360397564475, 7751.379889608705, 7826.178251283533, 7870.331021863206, 8059.476134051268, 37795.0, 38508.42237366498, 38525.0, 38831.223375531765, 39704.404433932934, 30995.535066973564, 31572.842135789175, 43161.0, 51339.743301283255, 51457.742711286206, 9210.539473026189, 9609.183219426428, 9669.371490853073, 9726.854097188689, 10007.349522281029, 10615.256932014994, 10726.302790318605, 10752.139828813833, 10805.405702686428, 10839.512221949873, 9116.0, 9372.753370254346, 9579.664711735057, 10052.095311422006, 10056.19550435978, 9433.52832358393, 9736.0, 9763.799922296075, 9864.358816676893, 10006.69979900604, 9453.716388508356, 9586.328956973224, 9950.115404660744, 10018.849717254392, 10158.339707918962, 8826.867596985921, 9103.772405689911, 9191.126842949909, 9194.12655797698, 9390.0, 8542.572871356531, 8726.69456569017, 9142.680006199751, 9256.213221876216, 9273.582688779155], "value": 5765.216926631445, "unit": "score"}], "name": "dromaeo_css", "value": 6086.003737267027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 115.0, 115.0, 115.0, 116.0, 115.0, 117.0, 116.0, 118.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 130.0, 179.0, 133.0, 127.0, 126.0, 127.0, 169.0, 127.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 163.0, 163.0, 163.0, 162.0, 161.0, 163.0, 161.0, 160.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 75.0, 77.0, 76.0, 75.0, 100.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 129.0, 83.0, 83.0, 83.0, 105.0, 82.0, 83.0, 120.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 84.0, 83.0, 83.0, 84.0, 82.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 140.0, 150.0, 140.0, 142.0, 138.0, 140.0, 182.0, 141.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 192.0, 180.0, 173.0, 178.0, 175.0, 173.0, 178.0, 173.0, 171.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 67.0, 68.0, 70.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1543.8999999999996, "alertThreshold": 2.0}]} 08:04:57 INFO - Return code: 0 08:04:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:04:57 INFO - # TBPL SUCCESS # 08:04:57 INFO - Running post-action listener: _resource_record_post_action 08:04:57 INFO - [mozharness: 2016-10-29 15:04:57.433155Z] Finished run-tests step (success) 08:04:57 INFO - Running post-run listener: _resource_record_post_run 08:04:57 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404803584; Read time: 12; Write time: 343712 08:04:57 INFO - TinderboxPrint: CPU usage
13.0% 08:04:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:04:57 INFO - TinderboxPrint: I/O write bytes / time
404,803,584 / 343,712 08:04:57 INFO - TinderboxPrint: CPU idle
8,332.9 (86.9%) 08:04:57 INFO - TinderboxPrint: CPU user
1,201.9 (12.5%) 08:04:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:04:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110821376; Read time: 0; Write time: 116788 08:04:57 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 293527552; Read time: 0; Write time: 226924 08:04:58 INFO - Running post-run listener: _upload_blobber_files 08:04:58 INFO - Blob upload gear active. 08:04:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:04:58 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 08:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:04:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:59 INFO - (blobuploader) - INFO - Done attempting. 08:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:00 INFO - (blobuploader) - INFO - Done attempting. 08:05:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:03 INFO - (blobuploader) - INFO - Done attempting. 08:05:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:03 INFO - Return code: 0 08:05:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3282740e7b80d7f8c1ab2a524f6a9228e14055a8aab3fd2f81ec32cf782fccd84649b78ba1db9d3545b5693de873fd1d147afa50cbe6dd06227e74948cf4338", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4e2e5ac99a4ebf71cb797ffb6454c1427295e9642880af4b2c557e4131865e8c4bbffd644dc239ab47030220655d2a81d9f0a8153f835f6fdac4b19956a7c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0fae781bc9ff0465d7806aef545512e74afa4f7cae4cf6bc0bae14b7b1b0afcf89badb44b6c109f89f4e4dc447007002be73f0e80bdc4a344b6e8b67b73b037"} 08:05:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:03 INFO - Contents: 08:05:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3282740e7b80d7f8c1ab2a524f6a9228e14055a8aab3fd2f81ec32cf782fccd84649b78ba1db9d3545b5693de873fd1d147afa50cbe6dd06227e74948cf4338", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4e2e5ac99a4ebf71cb797ffb6454c1427295e9642880af4b2c557e4131865e8c4bbffd644dc239ab47030220655d2a81d9f0a8153f835f6fdac4b19956a7c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0fae781bc9ff0465d7806aef545512e74afa4f7cae4cf6bc0bae14b7b1b0afcf89badb44b6c109f89f4e4dc447007002be73f0e80bdc4a344b6e8b67b73b037"} 08:05:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:03 INFO - Copying logs to upload dir... 08:05:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.108722 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-29 08:05:03.386067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 08:05:03.390008) ========= 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=62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3282740e7b80d7f8c1ab2a524f6a9228e14055a8aab3fd2f81ec32cf782fccd84649b78ba1db9d3545b5693de873fd1d147afa50cbe6dd06227e74948cf4338", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4e2e5ac99a4ebf71cb797ffb6454c1427295e9642880af4b2c557e4131865e8c4bbffd644dc239ab47030220655d2a81d9f0a8153f835f6fdac4b19956a7c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0fae781bc9ff0465d7806aef545512e74afa4f7cae4cf6bc0bae14b7b1b0afcf89badb44b6c109f89f4e4dc447007002be73f0e80bdc4a344b6e8b67b73b037"} build_url:https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/E3uKLc5bTfOp5lJ6tbdFew/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3282740e7b80d7f8c1ab2a524f6a9228e14055a8aab3fd2f81ec32cf782fccd84649b78ba1db9d3545b5693de873fd1d147afa50cbe6dd06227e74948cf4338", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4e2e5ac99a4ebf71cb797ffb6454c1427295e9642880af4b2c557e4131865e8c4bbffd644dc239ab47030220655d2a81d9f0a8153f835f6fdac4b19956a7c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0fae781bc9ff0465d7806aef545512e74afa4f7cae4cf6bc0bae14b7b1b0afcf89badb44b6c109f89f4e4dc447007002be73f0e80bdc4a344b6e8b67b73b037"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 08:05:03.415958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:05:03.416284) ========= 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=62c568580acbfdaac3eec7be000001dc-1477741718.957972-1326548092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:05:03.499379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 08:05:03.499746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 08:05:03.500077) ========= ========= Total master_lag: 0.18 =========