builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1475608758.28 results: success (0) buildid: 20161004113402 builduid: 61e0ff1d711e4a6bb1c5ec9346b695e9 revision: ad324639bfaeba6d7be3b732295b6a27d0c54e0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.280467) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.280923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.281197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.315870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.316227) ========= 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=6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 12:19:19-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-10-04 12:19:19 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.461261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.791344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.791655) ========= 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=6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015072 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.841873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:18.842279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad324639bfaeba6d7be3b732295b6a27d0c54e0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ad324639bfaeba6d7be3b732295b6a27d0c54e0a --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=6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 12:19:19,838 truncating revision to first 12 chars 2016-10-04 12:19:19,838 Setting DEBUG logging. 2016-10-04 12:19:19,838 attempt 1/10 2016-10-04 12:19:19,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad324639bfae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 12:19:20,166 unpacking tar archive at: fx-team-ad324639bfae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659471 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:19.515034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:19.515316) ========= script_repo_revision: ad324639bfaeba6d7be3b732295b6a27d0c54e0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:19.515703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:19.515975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 12:19:19.524930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 12:19:19.525226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:19:20 INFO - MultiFileLogger online at 20161004 12:19:20 in /builds/slave/test 12:19:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:19:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:20 INFO - {'append_to_log': False, 12:19:20 INFO - 'base_work_dir': '/builds/slave/test', 12:19:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:19:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:20 INFO - 'branch': 'Fx-Team-Non-PGO', 12:19:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:20 INFO - 'config_files': ('talos/linux_config.py',), 12:19:20 INFO - 'default_actions': ('clobber', 12:19:20 INFO - 'read-buildbot-config', 12:19:20 INFO - 'download-and-extract', 12:19:20 INFO - 'populate-webroot', 12:19:20 INFO - 'create-virtualenv', 12:19:20 INFO - 'install', 12:19:20 INFO - 'run-tests'), 12:19:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:20 INFO - 'download_minidump_stackwalk': True, 12:19:20 INFO - 'download_symbols': 'ondemand', 12:19:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:20 INFO - 'installer_path': 'installer.exe', 12:19:20 INFO - 'log_level': 'info', 12:19:20 INFO - 'log_name': 'talos', 12:19:20 INFO - 'log_to_console': True, 12:19:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:19:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:19:20 INFO - 'opt_config_files': (), 12:19:20 INFO - 'pip_index': False, 12:19:20 INFO - 'sps_profile': False, 12:19:20 INFO - 'sps_profile_interval': 0, 12:19:20 INFO - 'suite': 'dromaeojs', 12:19:20 INFO - 'system_bits': '32', 12:19:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:20 INFO - 'title': 'talos-linux64-ix-050', 12:19:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:20 INFO - 'use_talos_json': True, 12:19:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:20 INFO - 'work_dir': 'build'} 12:19:20 INFO - [mozharness: 2016-10-04 19:19:20.622300Z] Running clobber step. 12:19:20 INFO - Running pre-action listener: _resource_record_pre_action 12:19:20 INFO - Running main action method: clobber 12:19:20 INFO - rmtree: /builds/slave/test/build 12:19:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:21 INFO - Running post-action listener: _resource_record_post_action 12:19:21 INFO - [mozharness: 2016-10-04 19:19:21.077432Z] Finished clobber step (success) 12:19:21 INFO - [mozharness: 2016-10-04 19:19:21.077532Z] Running read-buildbot-config step. 12:19:21 INFO - Running pre-action listener: _resource_record_pre_action 12:19:21 INFO - Running main action method: read_buildbot_config 12:19:21 INFO - Using buildbot properties: 12:19:21 INFO - { 12:19:21 INFO - "project": "", 12:19:21 INFO - "product": "firefox", 12:19:21 INFO - "script_repo_revision": "production", 12:19:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:19:21 INFO - "repository": "", 12:19:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:19:21 INFO - "buildid": "20161004113402", 12:19:21 INFO - "pgo_build": "False", 12:19:21 INFO - "basedir": "/builds/slave/test", 12:19:21 INFO - "buildnumber": 3366, 12:19:21 INFO - "slavename": "talos-linux64-ix-050", 12:19:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:19:21 INFO - "platform": "ubuntu64_hw", 12:19:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:19:21 INFO - "branch": "fx-team", 12:19:21 INFO - "repo_path": "integration/fx-team", 12:19:21 INFO - "revision": "ad324639bfaeba6d7be3b732295b6a27d0c54e0a", 12:19:21 INFO - "stage_platform": "linux64", 12:19:21 INFO - "builduid": "61e0ff1d711e4a6bb1c5ec9346b695e9", 12:19:21 INFO - "slavebuilddir": "test" 12:19:21 INFO - } 12:19:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:19:21 INFO - Running post-action listener: _resource_record_post_action 12:19:21 INFO - [mozharness: 2016-10-04 19:19:21.079959Z] Finished read-buildbot-config step (success) 12:19:21 INFO - [mozharness: 2016-10-04 19:19:21.080046Z] Running download-and-extract step. 12:19:21 INFO - Running pre-action listener: _resource_record_pre_action 12:19:21 INFO - Running main action method: download_and_extract 12:19:21 INFO - mkdir: /builds/slave/test/build/tests 12:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:21 INFO - trying https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/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 12:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/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 12:19:21 INFO - Downloaded 1361 bytes. 12:19:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:19:21 INFO - Using the following test package requirements: 12:19:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:19:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:19:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'jsshell-linux-x86_64.zip'], 12:19:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:19:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:19:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:19:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:19:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:19:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:19:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:19:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:19:21 INFO - Fetch https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:19:22 INFO - Http code: 200 12:19:22 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 12:19:22 INFO - x-amz-cf-id: 3Zqtg9M3wdy-6khbl3C_9NpApUl9JMYVGm0BZnzOIEYfznwFmfMO8g== 12:19:22 INFO - x-amz-version-id: SjHP_lFSrYgZQpy7cCQ4d_ppm_V7B7sW 12:19:22 INFO - Expected file size: 20421126 12:19:22 INFO - Obtained file size: 20421126 12:19:26 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 12:19:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:19:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:19:26 INFO - Fetch https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:19:27 INFO - Http code: 200 12:19:27 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 12:19:27 INFO - x-amz-cf-id: S0xZu1M2jtvq6ga0mmQ8fu4m0JpZiPwbCFvPqBiwZjMulEfxaPPc9A== 12:19:27 INFO - x-amz-version-id: SjHP_lFSrYgZQpy7cCQ4d_ppm_V7B7sW 12:19:27 INFO - Expected file size: 20421126 12:19:27 INFO - Obtained file size: 20421126 12:19:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:19:31 INFO - Fetch https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:19:32 INFO - Http code: 200 12:19:32 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 12:19:32 INFO - x-amz-cf-id: MCxG08H3yCmqF2HbTn0GkTWGLmO0YLerLACBSyh_RsUeENj1aQ5ixw== 12:19:32 INFO - x-amz-version-id: C89a_jDsDcwRr6YGl6fHkmmXdszU866O 12:19:32 INFO - Expected file size: 14409006 12:19:32 INFO - Obtained file size: 14409006 12:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:33 INFO - trying https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:19:33 INFO - Downloading https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/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 12:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/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 12:19:34 INFO - Downloaded 55797297 bytes. 12:19:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:19:34 INFO - mkdir: /builds/slave/test/properties 12:19:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:34 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:34 INFO - Contents: 12:19:34 INFO - build_url:https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:19:35 INFO - Running post-action listener: _resource_record_post_action 12:19:35 INFO - Running post-action listener: set_extra_try_arguments 12:19:35 INFO - [mozharness: 2016-10-04 19:19:35.048457Z] Finished download-and-extract step (success) 12:19:35 INFO - [mozharness: 2016-10-04 19:19:35.048681Z] Running populate-webroot step. 12:19:35 INFO - Running pre-action listener: _resource_record_pre_action 12:19:35 INFO - Running main action method: populate_webroot 12:19:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:35 INFO - '--tppagecycles', 12:19:35 INFO - '7'], 12:19:35 INFO - 'tests': ['tsvgm']}}, 12:19:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['damp', 'tps']}, 12:19:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'tests': ['damp', 'tps']}, 12:19:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['dromaeo_dom']}, 12:19:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['basic_compositor_video']}, 12:19:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:19:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['a11yr', 12:19:35 INFO - 'ts_paint', 12:19:35 INFO - 'tpaint', 12:19:35 INFO - 'sessionrestore', 12:19:35 INFO - 'sessionrestore_no_auto_restore', 12:19:35 INFO - 'tabpaint']}, 12:19:35 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:35 INFO - 'ts_paint', 12:19:35 INFO - 'tpaint', 12:19:35 INFO - 'sessionrestore', 12:19:35 INFO - 'sessionrestore_no_auto_restore', 12:19:35 INFO - 'tabpaint']}, 12:19:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:35 INFO - 'ts_paint', 12:19:35 INFO - 'tpaint', 12:19:35 INFO - 'sessionrestore', 12:19:35 INFO - 'sessionrestore_no_auto_restore', 12:19:35 INFO - 'tabpaint']}, 12:19:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:35 INFO - 'ts_paint', 12:19:35 INFO - 'tpaint', 12:19:35 INFO - 'sessionrestore', 12:19:35 INFO - 'sessionrestore_no_auto_restore', 12:19:35 INFO - 'tabpaint']}, 12:19:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['a11yr', 12:19:35 INFO - 'ts_paint', 12:19:35 INFO - 'tpaint', 12:19:35 INFO - 'sessionrestore', 12:19:35 INFO - 'sessionrestore_no_auto_restore', 12:19:35 INFO - 'tabpaint']}, 12:19:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['a11yr', 12:19:35 INFO - 'ts_paint', 12:19:35 INFO - 'tpaint', 12:19:35 INFO - 'sessionrestore', 12:19:35 INFO - 'sessionrestore_no_auto_restore', 12:19:35 INFO - 'tabpaint']}, 12:19:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['tsvgx', 12:19:35 INFO - 'tsvgr_opacity', 12:19:35 INFO - 'tart', 12:19:35 INFO - 'tscrollx', 12:19:35 INFO - 'cart']}, 12:19:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:35 INFO - 'tsvgr_opacity', 12:19:35 INFO - 'tart', 12:19:35 INFO - 'tscrollx', 12:19:35 INFO - 'cart']}, 12:19:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'talos_options': ['--disable-e10s'], 12:19:35 INFO - 'tests': ['tp5o']}, 12:19:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'tests': ['tp5o']}, 12:19:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'talos_options': ['--disable-e10s', 12:19:35 INFO - '--xperf_path', 12:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:35 INFO - 'tests': ['tp5n']}, 12:19:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:35 INFO - 'talos_options': ['--xperf_path', 12:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:35 INFO - 'tests': ['tp5n']}}, 12:19:35 INFO - 'talos.zip': {'path': '', 12:19:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:35 INFO - Running post-action listener: _resource_record_post_action 12:19:35 INFO - [mozharness: 2016-10-04 19:19:35.068141Z] Finished populate-webroot step (success) 12:19:35 INFO - [mozharness: 2016-10-04 19:19:35.068228Z] Running create-virtualenv step. 12:19:35 INFO - Running pre-action listener: _resource_record_pre_action 12:19:35 INFO - Running main action method: create_virtualenv 12:19:35 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:19:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:35 INFO - Using real prefix '/usr' 12:19:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:37 INFO - Installing pip.................done. 12:19:37 INFO - Return code: 0 12:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:19:37 INFO - Reading from file tmpfile_stdout 12:19:37 INFO - Output received: 12:19:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:19:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:37 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:19:37 INFO - Using env: {'DISPLAY': ':0', 12:19:37 INFO - 'HOME': '/home/cltbld', 12:19:37 INFO - 'LANG': 'en_US.UTF-8', 12:19:37 INFO - 'LANGUAGE': 'en_US:en', 12:19:37 INFO - 'LOGNAME': 'cltbld', 12:19:37 INFO - 'MAIL': '/var/mail/cltbld', 12:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:37 INFO - 'MOZ_NO_REMOTE': '1', 12:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:37 INFO - 'NO_EM_RESTART': '1', 12:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:37 INFO - 'PWD': '/builds/slave/test', 12:19:37 INFO - 'SHELL': '/bin/bash', 12:19:37 INFO - 'SHLVL': '1', 12:19:37 INFO - 'TERM': 'linux', 12:19:37 INFO - 'TMOUT': '86400', 12:19:37 INFO - 'USER': 'cltbld', 12:19:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:37 INFO - '_': '/tools/buildbot/bin/python'} 12:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:19:38 INFO - Cleaning up... 12:19:38 INFO - Return code: 0 12:19:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', '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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:19: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 psutil>=3.1.1 12:19:38 INFO - Using env: {'DISPLAY': ':0', 12:19:38 INFO - 'HOME': '/home/cltbld', 12:19:38 INFO - 'LANG': 'en_US.UTF-8', 12:19:38 INFO - 'LANGUAGE': 'en_US:en', 12:19:38 INFO - 'LOGNAME': 'cltbld', 12:19:38 INFO - 'MAIL': '/var/mail/cltbld', 12:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:38 INFO - 'MOZ_NO_REMOTE': '1', 12:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:38 INFO - 'NO_EM_RESTART': '1', 12:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:38 INFO - 'PWD': '/builds/slave/test', 12:19:38 INFO - 'SHELL': '/bin/bash', 12:19:38 INFO - 'SHLVL': '1', 12:19:38 INFO - 'TERM': 'linux', 12:19:38 INFO - 'TMOUT': '86400', 12:19:38 INFO - 'USER': 'cltbld', 12:19:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:38 INFO - '_': '/tools/buildbot/bin/python'} 12:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:38 INFO - Downloading/unpacking psutil>=3.1.1 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:40 INFO - Installing collected packages: psutil 12:19:40 INFO - Running setup.py install for psutil 12:19:40 INFO - building 'psutil._psutil_linux' extension 12:19:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:19:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:19:40 INFO - building 'psutil._psutil_posix' extension 12:19:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:19:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:40 INFO - Successfully installed psutil 12:19:40 INFO - Cleaning up... 12:19:40 INFO - Return code: 0 12:19:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:19: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 mozsystemmonitor==0.3 12:19:40 INFO - Using env: {'DISPLAY': ':0', 12:19:40 INFO - 'HOME': '/home/cltbld', 12:19:40 INFO - 'LANG': 'en_US.UTF-8', 12:19:40 INFO - 'LANGUAGE': 'en_US:en', 12:19:40 INFO - 'LOGNAME': 'cltbld', 12:19:40 INFO - 'MAIL': '/var/mail/cltbld', 12:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:40 INFO - 'MOZ_NO_REMOTE': '1', 12:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:40 INFO - 'NO_EM_RESTART': '1', 12:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:40 INFO - 'PWD': '/builds/slave/test', 12:19:40 INFO - 'SHELL': '/bin/bash', 12:19:40 INFO - 'SHLVL': '1', 12:19:40 INFO - 'TERM': 'linux', 12:19:40 INFO - 'TMOUT': '86400', 12:19:40 INFO - 'USER': 'cltbld', 12:19:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:40 INFO - '_': '/tools/buildbot/bin/python'} 12:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:19:43 INFO - Installing collected packages: mozsystemmonitor 12:19:43 INFO - Running setup.py install for mozsystemmonitor 12:19:43 INFO - Successfully installed mozsystemmonitor 12:19:43 INFO - Cleaning up... 12:19:43 INFO - Return code: 0 12:19:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:19:43 INFO - Using env: {'DISPLAY': ':0', 12:19:43 INFO - 'HOME': '/home/cltbld', 12:19:43 INFO - 'LANG': 'en_US.UTF-8', 12:19:43 INFO - 'LANGUAGE': 'en_US:en', 12:19:43 INFO - 'LOGNAME': 'cltbld', 12:19:43 INFO - 'MAIL': '/var/mail/cltbld', 12:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:43 INFO - 'MOZ_NO_REMOTE': '1', 12:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:43 INFO - 'NO_EM_RESTART': '1', 12:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:43 INFO - 'PWD': '/builds/slave/test', 12:19:43 INFO - 'SHELL': '/bin/bash', 12:19:43 INFO - 'SHLVL': '1', 12:19:43 INFO - 'TERM': 'linux', 12:19:43 INFO - 'TMOUT': '86400', 12:19:43 INFO - 'USER': 'cltbld', 12:19:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:43 INFO - '_': '/tools/buildbot/bin/python'} 12:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:43 INFO - Downloading/unpacking jsonschema==2.5.1 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:45 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:45 INFO - warning: no files found matching '*.txt' 12:19:45 INFO - no previously-included directories found matching 'build' 12:19:45 INFO - no previously-included directories found matching 'dist' 12:19:45 INFO - no previously-included directories found matching '.git*' 12:19:45 INFO - Installing collected packages: jsonschema, functools32 12:19:45 INFO - Running setup.py install for functools32 12:19:45 INFO - warning: no files found matching '*.txt' 12:19:45 INFO - no previously-included directories found matching 'build' 12:19:45 INFO - no previously-included directories found matching 'dist' 12:19:45 INFO - no previously-included directories found matching '.git*' 12:19:45 INFO - Successfully installed jsonschema functools32 12:19:45 INFO - Cleaning up... 12:19:45 INFO - Return code: 0 12:19:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:45 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:19:45 INFO - Using env: {'DISPLAY': ':0', 12:19:45 INFO - 'HOME': '/home/cltbld', 12:19:45 INFO - 'LANG': 'en_US.UTF-8', 12:19:45 INFO - 'LANGUAGE': 'en_US:en', 12:19:45 INFO - 'LOGNAME': 'cltbld', 12:19:45 INFO - 'MAIL': '/var/mail/cltbld', 12:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:45 INFO - 'MOZ_NO_REMOTE': '1', 12:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:45 INFO - 'NO_EM_RESTART': '1', 12:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:45 INFO - 'PWD': '/builds/slave/test', 12:19:45 INFO - 'SHELL': '/bin/bash', 12:19:45 INFO - 'SHLVL': '1', 12:19:45 INFO - 'TERM': 'linux', 12:19:45 INFO - 'TMOUT': '86400', 12:19:45 INFO - 'USER': 'cltbld', 12:19:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:45 INFO - '_': '/tools/buildbot/bin/python'} 12:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:19:45 INFO - Cleaning up... 12:19:45 INFO - Return code: 0 12:19:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:45 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:19:45 INFO - Using env: {'DISPLAY': ':0', 12:19:45 INFO - 'HOME': '/home/cltbld', 12:19:45 INFO - 'LANG': 'en_US.UTF-8', 12:19:45 INFO - 'LANGUAGE': 'en_US:en', 12:19:45 INFO - 'LOGNAME': 'cltbld', 12:19:45 INFO - 'MAIL': '/var/mail/cltbld', 12:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:45 INFO - 'MOZ_NO_REMOTE': '1', 12:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:45 INFO - 'NO_EM_RESTART': '1', 12:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:45 INFO - 'PWD': '/builds/slave/test', 12:19:45 INFO - 'SHELL': '/bin/bash', 12:19:45 INFO - 'SHLVL': '1', 12:19:45 INFO - 'TERM': 'linux', 12:19:45 INFO - 'TMOUT': '86400', 12:19:45 INFO - 'USER': 'cltbld', 12:19:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:45 INFO - '_': '/tools/buildbot/bin/python'} 12:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:46 INFO - Downloading/unpacking blobuploader==1.2.4 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:48 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:48 INFO - Downloading docopt-0.6.1.tar.gz 12:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:48 INFO - Running setup.py install for blobuploader 12:19:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:48 INFO - Running setup.py install for requests 12:19:49 INFO - Running setup.py install for docopt 12:19:49 INFO - Successfully installed blobuploader requests docopt 12:19:49 INFO - Cleaning up... 12:19:49 INFO - Return code: 0 12:19:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:49 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:49 INFO - Using env: {'DISPLAY': ':0', 12:19:49 INFO - 'HOME': '/home/cltbld', 12:19:49 INFO - 'LANG': 'en_US.UTF-8', 12:19:49 INFO - 'LANGUAGE': 'en_US:en', 12:19:49 INFO - 'LOGNAME': 'cltbld', 12:19:49 INFO - 'MAIL': '/var/mail/cltbld', 12:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:49 INFO - 'MOZ_NO_REMOTE': '1', 12:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:49 INFO - 'NO_EM_RESTART': '1', 12:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:49 INFO - 'PWD': '/builds/slave/test', 12:19:49 INFO - 'SHELL': '/bin/bash', 12:19:49 INFO - 'SHLVL': '1', 12:19:49 INFO - 'TERM': 'linux', 12:19:49 INFO - 'TMOUT': '86400', 12:19:49 INFO - 'USER': 'cltbld', 12:19:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:49 INFO - '_': '/tools/buildbot/bin/python'} 12:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:49 INFO - Running setup.py (path:/tmp/pip-lgBxmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:49 INFO - Running setup.py (path:/tmp/pip-o4SRCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:49 INFO - Running setup.py (path:/tmp/pip-TS_UrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:49 INFO - Running setup.py (path:/tmp/pip-_k2QEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:49 INFO - Running setup.py (path:/tmp/pip-butBSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:50 INFO - Running setup.py (path:/tmp/pip-iNDXMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:50 INFO - Running setup.py (path:/tmp/pip-4f4sfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:50 INFO - Running setup.py (path:/tmp/pip-lJ30zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:50 INFO - Running setup.py (path:/tmp/pip-OgFvUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:50 INFO - Running setup.py (path:/tmp/pip-dIUNtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:50 INFO - Running setup.py (path:/tmp/pip-6nvcIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:50 INFO - Running setup.py (path:/tmp/pip-0s7YsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:50 INFO - Running setup.py (path:/tmp/pip-jz_Zx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:50 INFO - Running setup.py (path:/tmp/pip-03cfou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:50 INFO - Running setup.py (path:/tmp/pip-Y2abXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:50 INFO - Running setup.py (path:/tmp/pip-zDqUZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:50 INFO - Running setup.py (path:/tmp/pip-Ly6xte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:50 INFO - Running setup.py install for manifestparser 12:19:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:50 INFO - Running setup.py install for mozcrash 12:19:51 INFO - Running setup.py install for mozdebug 12:19:51 INFO - Running setup.py install for mozdevice 12:19:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Running setup.py install for mozfile 12:19:51 INFO - Running setup.py install for mozhttpd 12:19:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Running setup.py install for mozinfo 12:19:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Running setup.py install for mozInstall 12:19:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Running setup.py install for mozleak 12:19:51 INFO - Running setup.py install for mozlog 12:19:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:51 INFO - Running setup.py install for moznetwork 12:19:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:52 INFO - Running setup.py install for mozprocess 12:19:52 INFO - Running setup.py install for mozprofile 12:19:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:52 INFO - Running setup.py install for mozrunner 12:19:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:52 INFO - Running setup.py install for mozscreenshot 12:19:52 INFO - Running setup.py install for moztest 12:19:52 INFO - Running setup.py install for mozversion 12:19:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:52 INFO - Cleaning up... 12:19:52 INFO - Return code: 0 12:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:52 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:52 INFO - Using env: {'DISPLAY': ':0', 12:19:52 INFO - 'HOME': '/home/cltbld', 12:19:52 INFO - 'LANG': 'en_US.UTF-8', 12:19:52 INFO - 'LANGUAGE': 'en_US:en', 12:19:52 INFO - 'LOGNAME': 'cltbld', 12:19:52 INFO - 'MAIL': '/var/mail/cltbld', 12:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:52 INFO - 'MOZ_NO_REMOTE': '1', 12:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:52 INFO - 'NO_EM_RESTART': '1', 12:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:52 INFO - 'PWD': '/builds/slave/test', 12:19:52 INFO - 'SHELL': '/bin/bash', 12:19:52 INFO - 'SHLVL': '1', 12:19:52 INFO - 'TERM': 'linux', 12:19:52 INFO - 'TMOUT': '86400', 12:19:52 INFO - 'USER': 'cltbld', 12:19:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:52 INFO - '_': '/tools/buildbot/bin/python'} 12:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:52 INFO - Running setup.py (path:/tmp/pip-Z8bj2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:52 INFO - Running setup.py (path:/tmp/pip-1xt1vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:53 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)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:53 INFO - Running setup.py (path:/tmp/pip-tIYxJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:53 INFO - Running setup.py (path:/tmp/pip-XlLwLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:53 INFO - Running setup.py (path:/tmp/pip-Ew1G4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:53 INFO - Running setup.py (path:/tmp/pip-DjTFcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:53 INFO - Running setup.py (path:/tmp/pip-LJPGwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:53 INFO - Running setup.py (path:/tmp/pip-wh4GlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:53 INFO - Running setup.py (path:/tmp/pip-XY2tHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:53 INFO - Running setup.py (path:/tmp/pip-_Pu_3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:53 INFO - Running setup.py (path:/tmp/pip-3qTjP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:53 INFO - Running setup.py (path:/tmp/pip-fK8nrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:53 INFO - Running setup.py (path:/tmp/pip-Fjuo8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:53 INFO - Running setup.py (path:/tmp/pip-3rr64o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:53 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)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:53 INFO - Running setup.py (path:/tmp/pip-wJqDgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:53 INFO - Running setup.py (path:/tmp/pip-xMoQ6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:54 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)) 12:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:54 INFO - Running setup.py (path:/tmp/pip-ZCqUo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:19:54 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)) 12:19:54 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)) 12:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:56 INFO - Downloading blessings-1.6.tar.gz 12:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:56 INFO - Installing collected packages: blessings 12:19:56 INFO - Running setup.py install for blessings 12:19:56 INFO - Successfully installed blessings 12:19:56 INFO - Cleaning up... 12:19:56 INFO - Return code: 0 12:19:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:56 INFO - Reading from file tmpfile_stdout 12:19:56 INFO - Current package versions: 12:19:56 INFO - argparse == 1.2.1 12:19:56 INFO - blessings == 1.6 12:19:56 INFO - blobuploader == 1.2.4 12:19:56 INFO - docopt == 0.6.1 12:19:56 INFO - functools32 == 3.2.3-2 12:19:56 INFO - jsonschema == 2.5.1 12:19:56 INFO - manifestparser == 1.1 12:19:56 INFO - mozInstall == 1.12 12:19:56 INFO - mozcrash == 0.17 12:19:56 INFO - mozdebug == 0.1 12:19:56 INFO - mozdevice == 0.48 12:19:56 INFO - mozfile == 1.2 12:19:56 INFO - mozhttpd == 0.7 12:19:56 INFO - mozinfo == 0.9 12:19:56 INFO - mozleak == 0.1 12:19:56 INFO - mozlog == 3.4 12:19:56 INFO - moznetwork == 0.27 12:19:56 INFO - mozprocess == 0.23 12:19:56 INFO - mozprofile == 0.28 12:19:56 INFO - mozrunner == 6.12 12:19:56 INFO - mozscreenshot == 0.1 12:19:56 INFO - mozsystemmonitor == 0.3 12:19:56 INFO - moztest == 0.7 12:19:56 INFO - mozversion == 1.4 12:19:56 INFO - psutil == 3.1.1 12:19:56 INFO - requests == 1.2.3 12:19:56 INFO - wsgiref == 0.1.2 12:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:56 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:56 INFO - Using env: {'DISPLAY': ':0', 12:19:56 INFO - 'HOME': '/home/cltbld', 12:19:56 INFO - 'LANG': 'en_US.UTF-8', 12:19:56 INFO - 'LANGUAGE': 'en_US:en', 12:19:56 INFO - 'LOGNAME': 'cltbld', 12:19:56 INFO - 'MAIL': '/var/mail/cltbld', 12:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:56 INFO - 'MOZ_NO_REMOTE': '1', 12:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:56 INFO - 'NO_EM_RESTART': '1', 12:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:56 INFO - 'PWD': '/builds/slave/test', 12:19:56 INFO - 'SHELL': '/bin/bash', 12:19:56 INFO - 'SHLVL': '1', 12:19:56 INFO - 'TERM': 'linux', 12:19:56 INFO - 'TMOUT': '86400', 12:19:56 INFO - 'USER': 'cltbld', 12:19:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:56 INFO - '_': '/tools/buildbot/bin/python'} 12:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:19:56 INFO - Cleaning up... 12:19:56 INFO - Return code: 0 12:19:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:56 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 0x7f8567db2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdacca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:19:56 INFO - Using env: {'DISPLAY': ':0', 12:19:56 INFO - 'HOME': '/home/cltbld', 12:19:56 INFO - 'LANG': 'en_US.UTF-8', 12:19:56 INFO - 'LANGUAGE': 'en_US:en', 12:19:56 INFO - 'LOGNAME': 'cltbld', 12:19:56 INFO - 'MAIL': '/var/mail/cltbld', 12:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:56 INFO - 'MOZ_NO_REMOTE': '1', 12:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:56 INFO - 'NO_EM_RESTART': '1', 12:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:56 INFO - 'PWD': '/builds/slave/test', 12:19:56 INFO - 'SHELL': '/bin/bash', 12:19:56 INFO - 'SHLVL': '1', 12:19:56 INFO - 'TERM': 'linux', 12:19:56 INFO - 'TMOUT': '86400', 12:19:56 INFO - 'USER': 'cltbld', 12:19:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:56 INFO - '_': '/tools/buildbot/bin/python'} 12:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:56 INFO - Cleaning up... 12:19:56 INFO - Return code: 0 12:19:56 INFO - Running post-action listener: _resource_record_post_action 12:19:56 INFO - Running post-action listener: _start_resource_monitoring 12:19:56 INFO - Starting resource monitoring. 12:19:56 INFO - [mozharness: 2016-10-04 19:19:56.972255Z] Finished create-virtualenv step (success) 12:19:56 INFO - [mozharness: 2016-10-04 19:19:56.972758Z] Running install step. 12:19:56 INFO - Running pre-action listener: _resource_record_pre_action 12:19:56 INFO - Running main action method: install 12:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:57 INFO - Reading from file tmpfile_stdout 12:19:57 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:57 INFO - Reading from file tmpfile_stdout 12:19:57 INFO - Output received: 12:19:57 INFO - Usage: mozinstall [options] installer 12:19:57 INFO - Options: 12:19:57 INFO - -h, --help show this help message and exit 12:19:57 INFO - -d DEST, --destination=DEST 12:19:57 INFO - Directory to install application into. [default: 12:19:57 INFO - "/builds/slave/test"] 12:19:57 INFO - --app=APP Application being installed. [default: firefox] 12:19:57 INFO - mkdir: /builds/slave/test/build/application 12:19:57 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'] 12:19:57 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 12:20:13 INFO - Reading from file tmpfile_stdout 12:20:13 INFO - Output received: 12:20:13 INFO - /builds/slave/test/build/application/firefox/firefox 12:20:13 INFO - Running post-action listener: _resource_record_post_action 12:20:13 INFO - [mozharness: 2016-10-04 19:20:13.406096Z] Finished install step (success) 12:20:13 INFO - [mozharness: 2016-10-04 19:20:13.406341Z] Running run-tests step. 12:20:13 INFO - Running pre-action listener: _resource_record_pre_action 12:20:13 INFO - Running main action method: run_tests 12:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:13 INFO - Python 2.7.3 12:20:13 INFO - Return code: 0 12:20:13 INFO - grabbing minidump binary from tooltool 12:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:13 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 0xda9f60>, '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 0xdaad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdab1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:20:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:20:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:20:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:13 INFO - Return code: 0 12:20:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:20:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:20:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:20:13 INFO - Using env: {'DISPLAY': ':0', 12:20:13 INFO - 'HOME': '/home/cltbld', 12:20:13 INFO - 'LANG': 'en_US.UTF-8', 12:20:13 INFO - 'LANGUAGE': 'en_US:en', 12:20:13 INFO - 'LOGNAME': 'cltbld', 12:20:13 INFO - 'MAIL': '/var/mail/cltbld', 12:20:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:13 INFO - 'MOZ_NO_REMOTE': '1', 12:20:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:13 INFO - 'NO_EM_RESTART': '1', 12:20:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:13 INFO - 'PWD': '/builds/slave/test', 12:20:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:13 INFO - 'SHELL': '/bin/bash', 12:20:13 INFO - 'SHLVL': '1', 12:20:13 INFO - 'TERM': 'linux', 12:20:13 INFO - 'TMOUT': '86400', 12:20:13 INFO - 'USER': 'cltbld', 12:20:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426', 12:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:13 INFO - '_': '/tools/buildbot/bin/python'} 12:20:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:20:13 INFO - mozversion application_buildid: 20161004113402 12:20:13 INFO - mozversion application_changeset: ad324639bfaeba6d7be3b732295b6a27d0c54e0a 12:20:13 INFO - mozversion application_display_name: Nightly 12:20:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:13 INFO - mozversion application_name: Firefox 12:20:13 INFO - mozversion application_remotingname: firefox 12:20:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:20:13 INFO - mozversion application_vendor: Mozilla 12:20:13 INFO - mozversion application_version: 52.0a1 12:20:13 INFO - mozversion platform_buildid: 20161004113402 12:20:13 INFO - mozversion platform_changeset: ad324639bfaeba6d7be3b732295b6a27d0c54e0a 12:20:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:20:13 INFO - mozversion platform_version: 52.0a1 12:20:13 INFO - using testdate: 1475608813 12:20:13 INFO - actual date: 1475608813 12:20:13 INFO - starting webserver on 'localhost:49776' 12:20:13 INFO - SUITE-START | Running 2 tests 12:20:13 INFO - TEST-START | dromaeo_css 12:20:13 INFO - operating with platform_type : linux_ 12:20:13 INFO - Initialising browser for dromaeo_css test... 12:20:13 INFO - TEST-INFO | started process 24397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDEJu0g/profile http://localhost:49776/getInfo.html) 12:20:18 INFO - PROCESS | 24397 | __metrics Screen width/height:1600/1200 12:20:18 INFO - PROCESS | 24397 | colorDepth:24 12:20:18 INFO - PROCESS | 24397 | Browser inner width/height: 1024/697 12:20:18 INFO - PROCESS | 24397 | __metrics 12:20:18 INFO - PROCESS | 24397 | 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" 12:20:18 INFO - PROCESS | 24397 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:20:19 INFO - PROCESS | 24397 | console.error: PushService: 12:20:19 INFO - PROCESS | 24397 | stateChangeProcessEnqueue: Error transitioning state 12:20:19 INFO - PROCESS | 24397 | UnknownError 12:20:20 INFO - TEST-INFO | 24397: exit 0 12:20:20 INFO - Browser initialized. 12:20:20 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:20 INFO - TEST-INFO | started process 24478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDEJu0g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:32 INFO - PROCESS | 24478 | RSS: Main: 175058944 12:20:32 INFO - PROCESS | 24478 | 12:21:23 INFO - PROCESS | 24478 | 1475608883206 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] 12:23:36 INFO - PROCESS | 24478 | Cycle 1(1): loaded http://localhost:49776/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49776/tests/dromaeo/cssquery-ext.html) 12:23:38 INFO - PROCESS | 24478 | RSS: Main: 378261504 12:23:38 INFO - PROCESS | 24478 | 12:26:41 INFO - PROCESS | 24478 | Cycle 1(1): loaded http://localhost:49776/tests/dromaeo/cssquery-ext.html (next: http://localhost:49776/tests/dromaeo/cssquery-jquery.html) 12:26:42 INFO - PROCESS | 24478 | RSS: Main: 280616960 12:26:42 INFO - PROCESS | 24478 | 12:29:44 INFO - PROCESS | 24478 | Cycle 1(1): loaded http://localhost:49776/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49776/tests/dromaeo/cssquery-mootools.html) 12:29:45 INFO - PROCESS | 24478 | RSS: Main: 221900800 12:29:45 INFO - PROCESS | 24478 | 12:32:47 INFO - PROCESS | 24478 | Cycle 1(1): loaded http://localhost:49776/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49776/tests/dromaeo/cssquery-prototype.html) 12:32:48 INFO - PROCESS | 24478 | RSS: Main: 243998720 12:32:48 INFO - PROCESS | 24478 | 12:35:51 INFO - PROCESS | 24478 | Cycle 1(1): loaded http://localhost:49776/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49776/tests/dromaeo/cssquery-yui.html) 12:35:51 INFO - PROCESS | 24478 | RSS: Main: 221552640 12:35:51 INFO - PROCESS | 24478 | 12:38:54 INFO - PROCESS | 24478 | Cycle 1(1): loaded http://localhost:49776/tests/dromaeo/cssquery-yui.html (next: http://localhost:49776/tests/dromaeo/cssquery-dojo.html) 12:38:55 INFO - PROCESS | 24478 | RSS: Main: 314171392 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | __start_tp_report 12:38:55 INFO - PROCESS | 24478 | _x_x_mozilla_page_load 12:38:55 INFO - PROCESS | 24478 | _x_x_mozilla_page_load_details 12:38:55 INFO - PROCESS | 24478 | |i|pagename|runs| 12:38:55 INFO - PROCESS | 24478 | |0;dojo.html;2580.2001379572334;2596.0913680211916;2630.118910165095;2632.4998250332437;2646.4574762173756;4539.636829053676;4609.377734005908;4715.78778954947;4722.48052714202;4742.170120228959;4657.883552911179;4677.6959497632715;4734.9763251183695;4767.070421267854;4802.8078876844975;4249.617534421902;4257.212415703105;4309.870703878889;4312.1806856697285;4345.500267469234;4292.098659281554;4322.913541729164;4340.327249276352;4351.151525452522;4401.031773009949;4186.1418409226035;4223.577642235782;4292.892677683051;4303.2469317869245;4307.483102027745;4255.234057869582;4282.293421585435;4312.805923733439;4313.97843010783;4317;4229.36559516072;4262.7655478948645;4263.850765223233;4308.116836048634;4322.113966636832;4688.976555117237;4689.929651055237;4719.787609557578;4770.666053376265;4783.904321913542;5030.924536131961;5036.11867923112;5042.899142017139;5043.420006699203;5093.23601459784;4838.274258861199;4913;4915.680480768739;4979.47715489872;5045.117104506697;4613.723176609415;4635.605973492224;4646.976765116153;4648.581627653527;4663.114008338405;5070.087384270793;5087.6947383156385;5090.211017292326;5091.872703182376;5091.87270318245;4862.78117484714;4896.706197628154;4903.01939612079;4905.068037072945;4907.803687852517;4978.153713868651;4978.701277923336;4979.05397974391;4984.028114517634;4987;4731.006488637425;4902.093112774148;4965.4041515018425;5023;5032.169692000779;4946.060248552763;4946.554810067111;4948.480409556944;4951.653384263067;5011.924821127686;4217.8523751668545;4220.493540775126;4264.701470897069;4269.743815371087;4269.914601707948;3598.5501812273465;3600.0819790953665;3625.12996880752;3630.437282221207;3670.44943258508;4344.044310251739;4370.409994650745;4371.497277813092;4414.205443020223;4414.646828253732;5048.646594738407;5051.217061355495;5051.267566202953;5054.115529782273;5099.209622508517;4259.1268789897995;4306.031142992864;4355.760433176206;4362.629176519968;4408.140412619572;4455;4463.218936686067;4500.234960056799;4501.122281155143;4574.08518296342;4710.764461776966;4718.433787945469;4723.551262630044;4730.030343779448;4783.856484305337;4885.682430641997;5048.621353398436;5049.596032317332;5054.393472783289;5114.309568208244;4643.187442197534;4695.859124226278;4707.176244157327;4715.269133284346;4716.056788642217;4871.805127794849;4924.4090709115135;4924.507549245047;4925.950740492549;4930.063287975273;4968.3292755479;4988.27669987857;4998.60011199096;4999.550040496373;5010.398752149766;4835.105505481497;4868.561829435368;4874.317595536557;4874.463808981081;4874.756262186947;4852.369192005017;4855.028994201103;4896.461389247252;4954.950450495593;4958.801647934042;4819.036192761391;4819.975900120477;4828.251620998751;4836.806527738851;4893.119238537098;4752.714837109785;4803.855884323476;4927.088488629615;4932.556069953722;4979.875503112451;4761.166795810788;4795.376601041982;4809.182438985311;4821.879453013703;4865.1485989952325 12:38:55 INFO - PROCESS | 24478 | |1;ext.html;545.2883986397751;556.499150764312;586.437020460358;598.2701104652325;606.4632799972023;27391.04131355403;37261.25477490452;38661.613383866184;38662.420063699064;43148.35277470841;39946.40080398796;40456.39315410271;40466.59533404665;40521;40538;7611.238876112386;7741;7748.41886858485;7763.146053934062;7766.922330776676;7045.4715896307725;7324.414046876237;9666.758331041745;9953.751156221117;9969.50152492376;9939.602415903355;10012.89987100127;10029.448380339078;10034.197264218845;10041.548130334117;9986.550605222783;10008.349457285252;10022;10057.195424366033;10071.597136114546;9763.170130538912;9884.456354900478;9890.30767846251;9891.159251463634;9891.208703303719;37831.432528512094;38082;38119.428208576894;38138.80930595329;38188.61811381878;3051.25244315142;3137.8117312961294;3225.580674512322;3325.5676762021026;3386.356592247465;27314.726852731415;28014.439711205865;28044.859775700992;28047.439051218862;28119.85940070307;3152.5271209318557;3387.4749413840896;3488.372093023255;3508.8070156141403;3517.7889326640484;242714;242902;246926;247184.76407618026;247411;28466.430671386457;50492.74753626208;50945;50951.74524127356;50986.74506627517;30132.54801177984;32100.35799284048;32225.677743222735;32236;32290.515642265385;13063.934680326727;13265.66835829112;13268.601941941757;13280.468781248836;13287.468501260035;9073.54632268384;10179.796404071878;10189.082982531607;10193.286469947032;10198.33710808795;7182.102237220348;18309.267629294944;18878.716819247722;19218.807811921983;19834.60330793405;6889.242183359826;6935.375816176568;7009.404200642901;7117.89323160153;7202.819929501804;780.5082797837326;898.3531857062904;940.4639355567261;946.7396465971913;975.4050029482011;26395.340116497242;27610.171694849185;28542;30021.39957200844;30553;926.9490178040138;958.5255298627085;973.7955029443896;1000.7798284377425;1050.6847945616437;14127.15237085778;15025.924870375578;16001.199940002953;16122;16615.41846035383;380917;383562;383881;386097;386383;49022.509774901795;49425;49460.75269623701;49535;49626;1093.3330668292335;1107.894749998749;1111.09445801673;1183.7099910521806;1196.4376742930808;26387.60418593761;28347.85826070939;29031.564526531696;30842.537361940038;31588.684113159492;45149;45947;45996.54003460056;46056;46067.30899036584;267716;267858;268130;268281;268786;24558.263252102464;24931.875340623905;25350.74649253484;31267.53098703567;32587.674123259414;41411;42292.501974744315;42800.357994629485;43238.78380608077;47279.29081063856;35611.82194089013;35937;36108.81945590255;36386.27227455489;36579;35481;35641.28717425585;36065.81967090148;36397.27205455929;36754.63245367619;34579.827100864335;35008.474872877436;35389.469157962136;35545;36078.819605902856;30508.38983220279;33343.1664208387;33586.32827343488;33631;33748.662513374555;24945.50108997846;25593.217797283363;25667.871660641576;25731.614025790004;26190.86904565465 12:38:55 INFO - PROCESS | 24478 | |2;jquery.html;339.63658884993066;353.17357383722083;361.2089523942566;365.66541614422795;391.6788233648409;12162.452689628966;15862.286197121128;16330.2651380688;16642.417515386966;17605.383811566597;15643.765343519857;15666.530004099866;16101;17013.57466063349;17137.400190993318;4049.967258349117;4844.951550484503;4973.975130124344;5015.423226328982;5065.797368105272;4860.4896485869;4947.208446648537;4948.901021979558;4949.208126699728;4950.950490495103;4815.085133824579;4848.054629347279;4889.095517329288;4918.754062296889;4925.852224433273;4918.803247870081;4976.4277108132665;4978.502149785028;4979.875503112415;4984.700917944917;4269.935950960738;4375.0812329410865;4470.508244093147;4472.217361961643;4474.082813023322;18763.718544221847;19600.607987840165;20326.695099573517;20461.590768184702;20479.28322508705;1802.0352632785523;1810.7464954906325;1841.2542920117373;1877.11775465531;1947.123794292574;8428.261863581267;8635.309175266026;8847.77880552985;9068.183863452256;9181.403208791407;1668.1825905306434;1748.9300427982866;1752.570620198047;1792.2830867652913;1801.7837859456818;65540.67229663869;66459.66770166118;66940;69904.3009569908;71732.28267717308;9512.42925424463;9685.757856053655;9722.416655000723;9866.654667086617;9940.751481212883;13571.59285221445;13571.59285221445;13584.252866092262;13621.863781362059;13622.591322260349;6863.416609588241;7050.378412964944;7188.706032914126;7192.318068725648;7292.598907060163;6801.931980680229;6823.1812182538415;6992.965035174791;7001.229864714877;7016.087908571955;4070.3745296215325;4168.979155104265;4171.83312667496;4227.8097485613225;4333.58830911063;1640.9015459072493;1809.3848091648902;1820.7359932809668;1845.8246466585654;1860.6185731924922;804.8028233082932;808.846319199362;837.2715737308581;838.3754103193038;887.7248053103558;16341.673166536602;16526.256318465697;16963.406280780113;17109.23008464622;17414;827.9503229806231;833.954132522717;842.4776638484057;847.5084451018395;906.6282824042243;8821.779455513535;8996.190342869173;9563.282753793494;9598.42409455421;9790.657326993522;343121;349730;353313;364941;365107;75481.62259188668;75698.62150689322;78343.21656783359;78733.21266787259;78935;876.5266755951842;880.0451510111473;899.5412339706666;903.4037535226719;903.9728808135767;14589.343479543233;14817.851821482078;14966.251687415368;15274.465393711167;15483.922580387027;36151;37021.6297837029;37034.8148259257;37145.6285437153;37893.24213515659;49195.754021229666;49552;50294.24558631697;50340.49659503358;50636.493635063176;7358.448116391399;7557.244275572619;7697.081324747853;7835.647395867314;8094.83810323802;11703.531858725897;12049.759004820029;12071.215371000857;12251.326177059991;12310.199837010565;9795.914286999572;10330.638427654996;10602.257841951297;10642.8935710645;10993.450327483753;10373.377597344184;10469.581216751245;10563.15494760402;10609.734756631146;10926.945365273123;7107.933809928552;10505.9474702626;10512.26414151002;10629.787404251718;10795.19036072282;7797.337226335825;7948.841023179389;7956;8091.1504292048485;8174.550399727834;8775.473471591726;10573.207009474167;10583.841242381524;10619.256652034283;10971.396573188233 12:38:55 INFO - PROCESS | 24478 | |3;mootools.html;1259.250745806245;1313.632182988763;1376.236188915152;1411.9435222591096;1691.8139004709487;6684.866302673943;7206.531575447599;7464.29089236523;7760.068791744999;7778.8833167502535;7790.727324543642;7846.489978151416;7849.8037549061155;7849.921500784991;7861.449698521092;2120.480482281839;2139.208492857637;2141.9357419277367;2142.2180903970016;2144.345974477784;2074.408793493855;2123.2462475821094;2149.269248455525;2154.762976072631;2160.5786871560053;2111.292716939827;2128.7871212878667;2136.75427325858;2148.6347320955474;2155.9784402155933;2020.4140799168224;2027.0979414160704;2031.2281333093479;2033.3493282149718;2036.5112373030365;1996.6306233346877;2068.038362161587;2068.9482762930897;2070.834333253336;2072.471519762466;7822.491538050009;7851.528908265465;7908.406869484812;7914.169012253688;7921.603919804044;4439.178751930871;4599.034202817379;4601.677882548223;4640.721556706575;4651.534846515356;2703.9324016899536;2827.5475923852086;2848.401835614503;2874.2383268433673;2878.424315136981;867.7526904832156;872.6683860133172;877.1929824561419;884.3102380143498;886.0784783824814;9777.804443911082;9890.554925028391;9900.80198396028;9906.950465247699;9912;3620.855165793339;3629.872954446582;3788.45067465216;3814.3324918139215;3819.427085937132;7954.602269886483;7974.720884769005;7976;7976.641051152712;8004.07953085391;4359.2807186813825;4372.300431930876;4375.037491751809;4378.321360189176;4384.605385515319;3547.5742910850345;3661.707063434919;4001.4598029265676;4065.573114822901;4081;3234.450143475615;3278.491953655408;3368.4105281575626;3415.777974431654;3421.5723034620673;937.5593471068587;941.7786820097272;949.7055912667096;972.8929817720186;985.1380042462845;798.6525861250375;822.1285437436337;837.8491871463195;842.1536355962219;845.9746207613781;5076.543111119943;5330.573554115662;5468.343798744176;5539.2522009529;5559.359988803232;789.1083076123944;795.7851380127333;831.2892476932136;833.1127349372898;843.1821133500495;3344.8494817733263;3451.4995325677637;3694.3350196964266;3715.1269451678836;3723.4414837774007;9466.95266523663;9819.214462843098;9904;9928.255380846465;9932.404055756533;9749.366291191192;9831.852522212173;9878.753031174134;9888.752781180528;9902.564128201371;6997.615131167835;7171.533850299714;7281.745138920219;7297.270272972554;7297.781066567905;5065.29995059457;5231.032259032091;5240.187770895517;5325.121354976541;5465.316835395575;9039.68361107358;9116.270698343984;9127.543622818965;9128.224100951493;9140.771480713036;8542.530160840965;8883;8883.156100170732;9110.180083792491;9185.311101667268;6052.757889684363;6241.594296370721;6717.496187785838;6876.69054892521;6887.104676392037;7251.56490610565;7426.814329641802;7511.8497630046;7703.152653208031;7718.228177182237;6731.259561448139;6901.930980690129;6904.206016308189;6923.411510021705;7068.893966590608;6717.227518835396;6727.629980350932;6748.392644661808;6795;6926.722931082701;6127.816165515042;6217.96891015542;6221.9377806223165;6231.844203894758;6235.96882015587;4505.909881802411;4613.215753321876;4633.119707255745;4660.557247061523;4673.883152921204;4674.672772905864;4819.180739274402;4890.364252647133;4899.118158731462;4985.202367621163 12:38:55 INFO - PROCESS | 24478 | |4;prototype.html;270.73197534440897;278.2473409427499;288.72138386457067;291.072932709321;296.96881827408123;4688.578027977482;4787.784549695263;4812.195426714982;4865.294532292815;4865.878353041171;4630.467496237934;4783.689060211083;4784.545468180526;4791.664583479158;4839.612830973522;3838.86753407744;3849.7690138591634;3859.3053250414914;3860.806959652013;3864.555576108741;3532.4701294805727;3547.3260080584737;3831.1954489557224;3852.9807350963206;3854.614538546137;3669.5138468919995;3699.4450832375223;3712.0719820044988;3713.294474049935;3721.6836568891677;3703.3148867459604;3706.5737440194316;3712.832922518493;3726.1802403471193;3728.6017743346247;3251.1872031992;3256.755743319237;3257.8696852125886;3260.7065364117343;3266.96733032669;4584.724916504987;4660.650451216173;4681.859544213679;4683.180443422388;4687.742174180418;4279.122779830159;4296.677749168824;4296.73246392315;4304.461942257218;4305.4715575970395;4989.625778066623;5014.0723966066025;5017.5985921126585;5048.7728052237735;5065.240213967897;3426.7429942754393;3516.982415087934;3641;3644.398674218751;3649.543807024122;5157.616026377586;5169.198774189969;5220.4257531671865;5222.6605270657665;5224.4775522447835;3590.5870824855474;3607.3506768781344;3611.6930060944587;3614.855405783739;3624.6737793598704;3651.2514934438377;3655.744097913174;3663.19409729859;3680.9631903681156;3694.891532540227;4036.414719865603;4189.958100419018;4203;4210.915781684349;4239.851605193803;4964.478729733398;4968.478309777493;4995.275685025724;4996.275540046673;5011.473795251519;1206.8732783057653;1241.2862604002735;1258.7356655102349;1274.5602767045355;1292.6509842342703;892.8437523433373;914.2000749344323;919.3151102428733;924.117467818232;928.0626567167075;4432.977835110803;4440.911181776411;4450.821967121279;4459.1973444779605;4483.910321793546;5112;5125.743712814345;5134.5378915897745;5147.3051138096625;5148.510891465305;4296;4540.409746732969;4561.817527298871;4565.79006563261;4571.994161284512;2747.8763455644144;2758.3931535062256;2782.5687018512162;2790.772060293464;2792.2460935547288;4711.293306004059;4843.934334446416;4847;4878.463369029404;4900.534449227318;5246.921296180561;5253.55344795689;5270.181787283381;5275.20871869215;5291.814786482455;4828.975855120772;4839.806407743721;4845.466998630148;4859.95140048595;4864.659473836798;4980.228064649985;5090.898182036412;5127.256547800623;5130.921447131691;5149.176131818891;4980.302757614009;5009.298698182184;5037.395512538372;5038.1435156022835;5041.949580504148;4802.73584952831;4848.151573474698;4854.781534831011;4861.204807235783;4867.683600565952;3542.326957877995;3626.111602657366;3631.219287853124;3631.5279013729105;3646.34365814156;5082.695038297714;5107.872303192301;5122.462141475092;5138.409082955508;5140.177571588528;4967.7019378837385;4978.610267071754;4990.6007519397635;4991.425986011655;4994.575461085703;4769.2130798417875;4995.8001679932395;5000.000000000087;5010.69935803853;5063.860631357915;4650.9767451162525;4720.716756994591;4820.590249828804;4907.779149938333;4922.1140194765285;5021.924671129863;5024.924626130538;5047.460524540051;5049.823256186163;5068.771905264198;4938.654294199371;4944.48082951285;4945.282933974481;4969.204927211774;4979.427365852828 12:38:55 INFO - PROCESS | 24478 | |5;yui.html;603.6830663901451;613.1660941120078;643.630593841241;700.4711442860639;708.6952610377539;13361.933190334046;14159.22124283164;14168;14171.645708857284;14178.432862685493;13227.801582976263;13372.531961381354;13393.866061339384;13409.396577154028;13416.060875738678;613.7882430561449;630.7697690343037;709.9077119974409;729.4966473133547;754.6566312327877;764.652083302099;779.4504874063799;779.9415043871733;780.2509590792846;781.281221276427;835.9456635318716;838.2372041442288;838.4927119092953;838.7567605394428;839.3117643532306;655.0698008827476;672.868790585836;787.8030492376906;830.3108420011406;830.3523251863526;591.7189335065852;594.4738906068118;595.2143171014263;595.3064679648205;595.5354823237838;13486.865131348659;13511.459541618324;13528.32358382077;13530.120542164728;13535.526256581072;11987.820182697267;12056.63830085099;12110.333931633757;12374.938125309316;12803.743925121445;10510.894891051068;10526.42104684242;10557;10656.840147397796;10853.620123295646;3745.606711295302;3785.242951409729;3820.694344452465;3894.9221015579815;3901.8049097545295;59396.40603593952;59415.40584594142;59809.10286345752;60265.69867150636;61146.694266528386;8914.465132092095;9081.364304498622;9257.953710231406;9265.95367023174;9304.95347523258;17844.840085394666;17869.46391608254;18050.27798888056;18099.366522171662;18110.818891811177;6304.961337969133;6306.463950564162;6378.362163783678;6395.296517383084;6486.805395838132;3499.33512632599;3513.9648603514147;3514.7363947704025;3524.8413821377585;3562.2341196642847;2793.8184018038764;2922.6346706661666;2926.239177813784;2930.6483222013067;2936.6769655337894;481.6556162343871;483.53097495429375;483.5527137397893;484.0826633529442;494.9331840201527;411.8085090432963;481.97590120493834;484.32194927101636;484.9927251091236;504.6164914664881;6830.931690683129;7064.32888875556;7524.661390237453;7588.241175882367;7912.802179945433;516.2127755173316;518.4970578538812;561.8342588936274;570.1248583424424;576.3400905962649;3558.697510711567;3584.713222942158;3642.399004164336;3785.6592906638534;3810.371288737327;92301;97460;97555.51222243844;97677.51161244148;99316.50341748245;67318.32681673218;71270;78702.6064869672;79252;85079.5746021266;67714.66142669255;68058.31941680619;69800.30199697938;72252.43960966221;72339;8023.277904988579;8396.538190399342;8810.735677929672;8847.20375166238;8937.329700272636;38620.944800796635;41665.37501937534;41983.790081049396;42263.99999999877;43391.34912976371;55262;56853;62605;63943.360566395604;64774.35225647872;11048.613298534512;11052.557897684324;11111.611093611686;11250.324980501196;11613.245139065933;11620.88379116198;11919.582814601446;12043.698907527381;13023.934880325538;13057.608271751862;11715.707107322385;11771.293722376684;12124.515019399125;12340.444679989601;12582.685432864251;11453.59912403062;11578.94210528942;11829.053675706095;12200.206986545845;12240.387980600755;11294.43527823622;11311.151663625096;11759.529618815151;11765.823512647488;12137.635870923887;9329.953350233205;9754.75613109678;9953.900460995297;10095.949520252645;10426.582936682447;8818.470891746516;10260.948695256775;10356.792864142524;10365.533550990072;10382.896171038496 12:38:55 INFO - PROCESS | 24478 | __end_tp_report 12:38:55 INFO - PROCESS | 24478 | __start_cc_report 12:38:55 INFO - PROCESS | 24478 | _x_x_mozilla_cycle_collect,2260 12:38:55 INFO - PROCESS | 24478 | __end_cc_report 12:38:55 INFO - PROCESS | 24478 | __startTimestamp1475609935025__endTimestamp 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | ------- Summary: start ------- 12:38:55 INFO - PROCESS | 24478 | Number of tests: 6 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | [#0] dojo.html Cycles:165 Average:4621.77 Median:4761.17 stddev:485.62 (10.2%) stddev-sans-first:459.94 12:38:55 INFO - PROCESS | 24478 | Values: 2580.2 2596.1 2630.1 2632.5 2646.5 4539.6 4609.4 4715.8 4722.5 4742.2 4657.9 4677.7 4735.0 4767.1 4802.8 4249.6 4257.2 4309.9 4312.2 4345.5 4292.1 4322.9 4340.3 4351.2 4401.0 4186.1 4223.6 4292.9 4303.2 4307.5 4255.2 4282.3 4312.8 4314.0 4317.0 4229.4 4262.8 4263.9 4308.1 4322.1 4689.0 4689.9 4719.8 4770.7 4783.9 5030.9 5036.1 5042.9 5043.4 5093.2 4838.3 4913.0 4915.7 4979.5 5045.1 4613.7 4635.6 4647.0 4648.6 4663.1 5070.1 5087.7 5090.2 5091.9 5091.9 4862.8 4896.7 4903.0 4905.1 4907.8 4978.2 4978.7 4979.1 4984.0 4987.0 4731.0 4902.1 4965.4 5023.0 5032.2 4946.1 4946.6 4948.5 4951.7 5011.9 4217.9 4220.5 4264.7 4269.7 4269.9 3598.6 3600.1 3625.1 3630.4 3670.4 4344.0 4370.4 4371.5 4414.2 4414.6 5048.6 5051.2 5051.3 5054.1 5099.2 4259.1 4306.0 4355.8 4362.6 4408.1 4455.0 4463.2 4500.2 4501.1 4574.1 4710.8 4718.4 4723.6 4730.0 4783.9 4885.7 5048.6 5049.6 5054.4 5114.3 4643.2 4695.9 4707.2 4715.3 4716.1 4871.8 4924.4 4924.5 4926.0 4930.1 4968.3 4988.3 4998.6 4999.6 5010.4 4835.1 4868.6 4874.3 4874.5 4874.8 4852.4 4855.0 4896.5 4955.0 4958.8 4819.0 4820.0 4828.3 4836.8 4893.1 4752.7 4803.9 4927.1 4932.6 4979.9 4761.2 4795.4 4809.2 4821.9 4865.1 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | [#1] ext.html Cycles:180 Average:45245.38 Median:3513.30 stddev:80216.26 (2283.2%) stddev-sans-first:80371.08 12:38:55 INFO - PROCESS | 24478 | Values: 545.3 556.5 586.4 598.3 606.5 27391.0 37261.3 38661.6 38662.4 43148.4 39946.4 40456.4 40466.6 40521.0 40538.0 7611.2 7741.0 7748.4 7763.1 7766.9 7045.5 7324.4 9666.8 9953.8 9969.5 9939.6 10012.9 10029.4 10034.2 10041.5 9986.6 10008.3 10022.0 10057.2 10071.6 9763.2 9884.5 9890.3 9891.2 9891.2 37831.4 38082.0 38119.4 38138.8 38188.6 3051.3 3137.8 3225.6 3325.6 3386.4 27314.7 28014.4 28044.9 28047.4 28119.9 3152.5 3387.5 3488.4 3508.8 3517.8 242714.0 242902.0 246926.0 247184.8 247411.0 28466.4 50492.7 50945.0 50951.7 50986.7 30132.5 32100.4 32225.7 32236.0 32290.5 13063.9 13265.7 13268.6 13280.5 13287.5 9073.5 10179.8 10189.1 10193.3 10198.3 7182.1 18309.3 18878.7 19218.8 19834.6 6889.2 6935.4 7009.4 7117.9 7202.8 780.5 898.4 940.5 946.7 975.4 26395.3 27610.2 28542.0 30021.4 30553.0 926.9 958.5 973.8 1000.8 1050.7 14127.2 15025.9 16001.2 16122.0 16615.4 380917.0 383562.0 383881.0 386097.0 386383.0 49022.5 49425.0 49460.8 49535.0 49626.0 1093.3 1107.9 1111.1 1183.7 1196.4 26387.6 28347.9 29031.6 30842.5 31588.7 45149.0 45947.0 45996.5 46056.0 46067.3 267716.0 267858.0 268130.0 268281.0 268786.0 24558.3 24931.9 25350.7 31267.5 32587.7 41411.0 42292.5 42800.4 43238.8 47279.3 35611.8 35937.0 36108.8 36386.3 36579.0 35481.0 35641.3 36065.8 36397.3 36754.6 34579.8 35008.5 35389.5 35545.0 36078.8 30508.4 33343.2 33586.3 33631.0 33748.7 24945.5 25593.2 25667.9 25731.6 26190.9 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | [#2] jquery.html Cycles:180 Average:23134.83 Median:4471.36 stddev:58932.39 (1318.0%) stddev-sans-first:59072.85 12:38:55 INFO - PROCESS | 24478 | Values: 339.6 353.2 361.2 365.7 391.7 12162.5 15862.3 16330.3 16642.4 17605.4 15643.8 15666.5 16101.0 17013.6 17137.4 4050.0 4845.0 4974.0 5015.4 5065.8 4860.5 4947.2 4948.9 4949.2 4951.0 4815.1 4848.1 4889.1 4918.8 4925.9 4918.8 4976.4 4978.5 4979.9 4984.7 4269.9 4375.1 4470.5 4472.2 4474.1 18763.7 19600.6 20326.7 20461.6 20479.3 1802.0 1810.7 1841.3 1877.1 1947.1 8428.3 8635.3 8847.8 9068.2 9181.4 1668.2 1748.9 1752.6 1792.3 1801.8 65540.7 66459.7 66940.0 69904.3 71732.3 9512.4 9685.8 9722.4 9866.7 9940.8 13571.6 13571.6 13584.3 13621.9 13622.6 6863.4 7050.4 7188.7 7192.3 7292.6 6801.9 6823.2 6993.0 7001.2 7016.1 4070.4 4169.0 4171.8 4227.8 4333.6 1640.9 1809.4 1820.7 1845.8 1860.6 804.8 808.8 837.3 838.4 887.7 16341.7 16526.3 16963.4 17109.2 17414.0 828.0 834.0 842.5 847.5 906.6 8821.8 8996.2 9563.3 9598.4 9790.7 343121.0 349730.0 353313.0 364941.0 365107.0 75481.6 75698.6 78343.2 78733.2 78935.0 876.5 880.0 899.5 903.4 904.0 14589.3 14817.9 14966.3 15274.5 15483.9 36151.0 37021.6 37034.8 37145.6 37893.2 49195.8 49552.0 50294.2 50340.5 50636.5 7358.4 7557.2 7697.1 7835.6 8094.8 11703.5 12049.8 12071.2 12251.3 12310.2 9795.9 10330.6 10602.3 10642.9 10993.5 10373.4 10469.6 10563.2 10609.7 10926.9 7107.9 10505.9 10512.3 10629.8 10795.2 7797.3 7948.8 7956.0 8091.2 8174.6 8775.5 10573.2 10583.8 10619.3 10971.4 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | [#3] mootools.html Cycles:180 Average:5046.39 Median:6238.78 stddev:2858.93 (45.8%) stddev-sans-first:2852.78 12:38:55 INFO - PROCESS | 24478 | Values: 1259.3 1313.6 1376.2 1411.9 1691.8 6684.9 7206.5 7464.3 7760.1 7778.9 7790.7 7846.5 7849.8 7849.9 7861.4 2120.5 2139.2 2141.9 2142.2 2144.3 2074.4 2123.2 2149.3 2154.8 2160.6 2111.3 2128.8 2136.8 2148.6 2156.0 2020.4 2027.1 2031.2 2033.3 2036.5 1996.6 2068.0 2068.9 2070.8 2072.5 7822.5 7851.5 7908.4 7914.2 7921.6 4439.2 4599.0 4601.7 4640.7 4651.5 2703.9 2827.5 2848.4 2874.2 2878.4 867.8 872.7 877.2 884.3 886.1 9777.8 9890.6 9900.8 9907.0 9912.0 3620.9 3629.9 3788.5 3814.3 3819.4 7954.6 7974.7 7976.0 7976.6 8004.1 4359.3 4372.3 4375.0 4378.3 4384.6 3547.6 3661.7 4001.5 4065.6 4081.0 3234.5 3278.5 3368.4 3415.8 3421.6 937.6 941.8 949.7 972.9 985.1 798.7 822.1 837.8 842.2 846.0 5076.5 5330.6 5468.3 5539.3 5559.4 789.1 795.8 831.3 833.1 843.2 3344.8 3451.5 3694.3 3715.1 3723.4 9467.0 9819.2 9904.0 9928.3 9932.4 9749.4 9831.9 9878.8 9888.8 9902.6 6997.6 7171.5 7281.7 7297.3 7297.8 5065.3 5231.0 5240.2 5325.1 5465.3 9039.7 9116.3 9127.5 9128.2 9140.8 8542.5 8883.0 8883.2 9110.2 9185.3 6052.8 6241.6 6717.5 6876.7 6887.1 7251.6 7426.8 7511.8 7703.2 7718.2 6731.3 6901.9 6904.2 6923.4 7068.9 6717.2 6727.6 6748.4 6795.0 6926.7 6127.8 6218.0 6221.9 6231.8 6236.0 4505.9 4613.2 4633.1 4660.6 4673.9 4674.7 4819.2 4890.4 4899.1 4985.2 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | [#4] prototype.html Cycles:180 Average:4159.85 Median:4776.45 stddev:1202.01 (25.2%) stddev-sans-first:1169.40 12:38:55 INFO - PROCESS | 24478 | Values: 270.7 278.2 288.7 291.1 297.0 4688.6 4787.8 4812.2 4865.3 4865.9 4630.5 4783.7 4784.5 4791.7 4839.6 3838.9 3849.8 3859.3 3860.8 3864.6 3532.5 3547.3 3831.2 3853.0 3854.6 3669.5 3699.4 3712.1 3713.3 3721.7 3703.3 3706.6 3712.8 3726.2 3728.6 3251.2 3256.8 3257.9 3260.7 3267.0 4584.7 4660.7 4681.9 4683.2 4687.7 4279.1 4296.7 4296.7 4304.5 4305.5 4989.6 5014.1 5017.6 5048.8 5065.2 3426.7 3517.0 3641.0 3644.4 3649.5 5157.6 5169.2 5220.4 5222.7 5224.5 3590.6 3607.4 3611.7 3614.9 3624.7 3651.3 3655.7 3663.2 3681.0 3694.9 4036.4 4190.0 4203.0 4210.9 4239.9 4964.5 4968.5 4995.3 4996.3 5011.5 1206.9 1241.3 1258.7 1274.6 1292.7 892.8 914.2 919.3 924.1 928.1 4433.0 4440.9 4450.8 4459.2 4483.9 5112.0 5125.7 5134.5 5147.3 5148.5 4296.0 4540.4 4561.8 4565.8 4572.0 2747.9 2758.4 2782.6 2790.8 2792.2 4711.3 4843.9 4847.0 4878.5 4900.5 5246.9 5253.6 5270.2 5275.2 5291.8 4829.0 4839.8 4845.5 4860.0 4864.7 4980.2 5090.9 5127.3 5130.9 5149.2 4980.3 5009.3 5037.4 5038.1 5041.9 4802.7 4848.2 4854.8 4861.2 4867.7 3542.3 3626.1 3631.2 3631.5 3646.3 5082.7 5107.9 5122.5 5138.4 5140.2 4967.7 4978.6 4990.6 4991.4 4994.6 4769.2 4995.8 5000.0 5010.7 5063.9 4651.0 4720.7 4820.6 4907.8 4922.1 5021.9 5024.9 5047.5 5049.8 5068.8 4938.7 4944.5 4945.3 4969.2 4979.4 12:38:55 INFO - PROCESS | 24478 | 12:38:55 INFO - PROCESS | 24478 | [#5] yui.html Cycles:180 Average:17157.28 Median:483.82 stddev:24189.38 (4999.7%) stddev-sans-first:24225.30 12:38:55 INFO - PROCESS | 24478 | Values: 603.7 613.2 643.6 700.5 708.7 13361.9 14159.2 14168.0 14171.6 14178.4 13227.8 13372.5 13393.9 13409.4 13416.1 613.8 630.8 709.9 729.5 754.7 764.7 779.5 779.9 780.3 781.3 835.9 838.2 838.5 838.8 839.3 655.1 672.9 787.8 830.3 830.4 591.7 594.5 595.2 595.3 595.5 13486.9 13511.5 13528.3 13530.1 13535.5 11987.8 12056.6 12110.3 12374.9 12803.7 10510.9 10526.4 10557.0 10656.8 10853.6 3745.6 3785.2 3820.7 3894.9 3901.8 59396.4 59415.4 59809.1 60265.7 61146.7 8914.5 9081.4 9258.0 9266.0 9305.0 17844.8 17869.5 18050.3 18099.4 18110.8 6305.0 6306.5 6378.4 6395.3 6486.8 3499.3 3514.0 3514.7 3524.8 3562.2 2793.8 2922.6 2926.2 2930.6 2936.7 481.7 483.5 483.6 484.1 494.9 411.8 482.0 484.3 485.0 504.6 6830.9 7064.3 7524.7 7588.2 7912.8 516.2 518.5 561.8 570.1 576.3 3558.7 3584.7 3642.4 3785.7 3810.4 92301.0 97460.0 97555.5 97677.5 99316.5 67318.3 71270.0 78702.6 79252.0 85079.6 67714.7 68058.3 69800.3 72252.4 72339.0 8023.3 8396.5 8810.7 8847.2 8937.3 38620.9 41665.4 41983.8 42264.0 43391.3 55262.0 56853.0 62605.0 63943.4 64774.4 11048.6 11052.6 11111.6 11250.3 11613.2 11620.9 11919.6 12043.7 13023.9 13057.6 11715.7 11771.3 12124.5 12340.4 12582.7 11453.6 11578.9 11829.1 12200.2 12240.4 11294.4 11311.2 11759.5 11765.8 12137.6 9330.0 9754.8 9953.9 10095.9 10426.6 8818.5 10260.9 10356.8 10365.5 10382.9 12:38:55 INFO - PROCESS | 24478 | -------- Summary: end -------- 12:38:55 INFO - PROCESS | 24478 | 12:38:56 INFO - TEST-INFO | 24478: exit 0 12:38:56 INFO - TEST-OK | dromaeo_css | took 1122344ms 12:38:56 INFO - TEST-START | kraken 12:38:56 INFO - operating with platform_type : linux_ 12:38:56 INFO - Initialising browser for kraken test... 12:38:56 INFO - TEST-INFO | started process 24784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp90F1Gh/profile http://localhost:49776/getInfo.html) 12:39:00 INFO - PROCESS | 24784 | __metrics Screen width/height:1600/1200 12:39:00 INFO - PROCESS | 24784 | colorDepth:24 12:39:00 INFO - PROCESS | 24784 | Browser inner width/height: 1024/697 12:39:00 INFO - PROCESS | 24784 | __metrics 12:39:00 INFO - PROCESS | 24784 | 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" 12:39:00 INFO - PROCESS | 24784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:01 INFO - PROCESS | 24784 | console.error: PushService: 12:39:01 INFO - PROCESS | 24784 | stateChangeProcessEnqueue: Error transitioning state 12:39:01 INFO - PROCESS | 24784 | UnknownError 12:39:02 INFO - TEST-INFO | 24784: exit 0 12:39:02 INFO - Browser initialized. 12:39:02 INFO - Running cycle 1/1 for kraken test... 12:39:02 INFO - TEST-INFO | started process 24866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp90F1Gh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:14 INFO - PROCESS | 24866 | RSS: Main: 175542272 12:39:14 INFO - PROCESS | 24866 | 12:39:17 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49776/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:18 INFO - PROCESS | 24866 | RSS: Main: 242814976 12:39:18 INFO - PROCESS | 24866 | 12:39:20 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49776/tests/kraken/driver.html?testName=audio-dft) 12:39:21 INFO - PROCESS | 24866 | RSS: Main: 218910720 12:39:21 INFO - PROCESS | 24866 | 12:39:24 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49776/tests/kraken/driver.html?testName=audio-fft) 12:39:25 INFO - PROCESS | 24866 | RSS: Main: 301301760 12:39:25 INFO - PROCESS | 24866 | 12:39:27 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49776/tests/kraken/driver.html?testName=audio-oscillator) 12:39:28 INFO - PROCESS | 24866 | RSS: Main: 212086784 12:39:28 INFO - PROCESS | 24866 | 12:39:30 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49776/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:31 INFO - PROCESS | 24866 | RSS: Main: 214376448 12:39:31 INFO - PROCESS | 24866 | 12:39:34 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49776/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:34 INFO - PROCESS | 24866 | RSS: Main: 250683392 12:39:34 INFO - PROCESS | 24866 | 12:39:38 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49776/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:38 INFO - PROCESS | 24866 | RSS: Main: 250155008 12:39:38 INFO - PROCESS | 24866 | 12:39:41 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49776/tests/kraken/driver.html?testName=json-parse-financial) 12:39:42 INFO - PROCESS | 24866 | RSS: Main: 249765888 12:39:42 INFO - PROCESS | 24866 | 12:39:44 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49776/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:44 INFO - PROCESS | 24866 | RSS: Main: 212393984 12:39:44 INFO - PROCESS | 24866 | 12:39:46 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:47 INFO - PROCESS | 24866 | RSS: Main: 218996736 12:39:47 INFO - PROCESS | 24866 | 12:39:49 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:49 INFO - PROCESS | 24866 | RSS: Main: 228577280 12:39:49 INFO - PROCESS | 24866 | 12:39:52 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:53 INFO - PROCESS | 24866 | RSS: Main: 237420544 12:39:53 INFO - PROCESS | 24866 | 12:39:56 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:57 INFO - PROCESS | 24866 | RSS: Main: 233426944 12:39:57 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | Cycle 1(1): loaded http://localhost:49776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49776/tests/kraken/driver.html?testName=ai-astar) 12:39:59 INFO - PROCESS | 24866 | RSS: Main: 284086272 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | __start_tp_report 12:39:59 INFO - PROCESS | 24866 | _x_x_mozilla_page_load 12:39:59 INFO - PROCESS | 24866 | _x_x_mozilla_page_load_details 12:39:59 INFO - PROCESS | 24866 | |i|pagename|runs| 12:39:59 INFO - PROCESS | 24866 | |0;ai-astar;113;114;117;115;113;114;113;114;114;114 12:39:59 INFO - PROCESS | 24866 | |1;audio-beat-detection;160;132;127;175;133;134;136;127;166;129 12:39:59 INFO - PROCESS | 24866 | |2;audio-dft;162;161;161;162;162;160;162;161;162;162 12:39:59 INFO - PROCESS | 24866 | |3;audio-fft;75;76;76;106;77;79;77;78;99;76 12:39:59 INFO - PROCESS | 24866 | |4;audio-oscillator;85;83;118;83;84;83;104;83;83;114 12:39:59 INFO - PROCESS | 24866 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 12:39:59 INFO - PROCESS | 24866 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;146;146 12:39:59 INFO - PROCESS | 24866 | |7;imaging-desaturate;95;95;95;95;94;95;95;96;95;94 12:39:59 INFO - PROCESS | 24866 | |8;json-parse-financial;67;65;64;67;65;66;66;66;66;66 12:39:59 INFO - PROCESS | 24866 | |9;json-stringify-tinderbox;66;66;66;67;67;65;66;67;66;70 12:39:59 INFO - PROCESS | 24866 | |10;stanford-crypto-aes;84;87;83;83;86;83;94;84;83;85 12:39:59 INFO - PROCESS | 24866 | |11;stanford-crypto-ccm;146;140;139;141;146;150;141;140;182;139 12:39:59 INFO - PROCESS | 24866 | |12;stanford-crypto-pbkdf2;183;183;178;184;182;189;185;186;177;176 12:39:59 INFO - PROCESS | 24866 | |13;stanford-crypto-sha256-iterative;71;74;72;72;71;71;73;71;70;70 12:39:59 INFO - PROCESS | 24866 | __end_tp_report 12:39:59 INFO - PROCESS | 24866 | __start_cc_report 12:39:59 INFO - PROCESS | 24866 | _x_x_mozilla_cycle_collect,1915 12:39:59 INFO - PROCESS | 24866 | __end_cc_report 12:39:59 INFO - PROCESS | 24866 | __startTimestamp1475609999307__endTimestamp 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | ------- Summary: start ------- 12:39:59 INFO - PROCESS | 24866 | Number of tests: 14 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.20 12:39:59 INFO - PROCESS | 24866 | Values: 113.0 114.0 117.0 115.0 113.0 114.0 113.0 114.0 114.0 114.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:135.00 stddev:17.92 (13.3%) stddev-sans-first:17.77 12:39:59 INFO - PROCESS | 24866 | Values: 160.0 132.0 127.0 175.0 133.0 134.0 136.0 127.0 166.0 129.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 12:39:59 INFO - PROCESS | 24866 | Values: 162.0 161.0 161.0 162.0 162.0 160.0 162.0 161.0 162.0 162.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.04 (14.3%) stddev-sans-first:11.42 12:39:59 INFO - PROCESS | 24866 | Values: 75.0 76.0 76.0 106.0 77.0 79.0 77.0 78.0 99.0 76.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:14.23 (17.1%) stddev-sans-first:14.86 12:39:59 INFO - PROCESS | 24866 | Values: 85.0 83.0 118.0 83.0 84.0 83.0 104.0 83.0 83.0 114.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:39:59 INFO - PROCESS | 24866 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 12:39:59 INFO - PROCESS | 24866 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:39:59 INFO - PROCESS | 24866 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 94.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 12:39:59 INFO - PROCESS | 24866 | Values: 67.0 65.0 64.0 67.0 65.0 66.0 66.0 66.0 66.0 66.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 12:39:59 INFO - PROCESS | 24866 | Values: 66.0 66.0 66.0 67.0 67.0 65.0 66.0 67.0 66.0 70.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:3.39 (4.0%) stddev-sans-first:3.57 12:39:59 INFO - PROCESS | 24866 | Values: 84.0 87.0 83.0 83.0 86.0 83.0 94.0 84.0 83.0 85.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:143.50 stddev:13.04 (9.1%) stddev-sans-first:13.83 12:39:59 INFO - PROCESS | 24866 | Values: 146.0 140.0 139.0 141.0 146.0 150.0 141.0 140.0 182.0 139.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:183.50 stddev:4.16 (2.3%) stddev-sans-first:4.41 12:39:59 INFO - PROCESS | 24866 | Values: 183.0 183.0 178.0 184.0 182.0 189.0 185.0 186.0 177.0 176.0 12:39:59 INFO - PROCESS | 24866 | 12:39:59 INFO - PROCESS | 24866 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 12:39:59 INFO - PROCESS | 24866 | Values: 71.0 74.0 72.0 72.0 71.0 71.0 73.0 71.0 70.0 70.0 12:39:59 INFO - PROCESS | 24866 | -------- Summary: end -------- 12:39:59 INFO - PROCESS | 24866 | 12:40:00 INFO - TEST-INFO | 24866: exit 0 12:40:00 INFO - TEST-OK | kraken | took 64708ms 12:40:00 INFO - SUITE-END | took 1187s 12:40:00 INFO - Completed test suite (00:19:47) 12:40:00 INFO - javascript benchmark 12:40:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.2001379572334, 2596.0913680211916, 2630.118910165095, 2632.4998250332437, 2646.4574762173756, 4539.636829053676, 4609.377734005908, 4715.78778954947, 4722.48052714202, 4742.170120228959, 4657.883552911179, 4677.6959497632715, 4734.9763251183695, 4767.070421267854, 4802.8078876844975, 4249.617534421902, 4257.212415703105, 4309.870703878889, 4312.1806856697285, 4345.500267469234, 4292.098659281554, 4322.913541729164, 4340.327249276352, 4351.151525452522, 4401.031773009949, 4186.1418409226035, 4223.577642235782, 4292.892677683051, 4303.2469317869245, 4307.483102027745, 4255.234057869582, 4282.293421585435, 4312.805923733439, 4313.97843010783, 4317.0, 4229.36559516072, 4262.7655478948645, 4263.850765223233, 4308.116836048634, 4322.113966636832, 4688.976555117237, 4689.929651055237, 4719.787609557578, 4770.666053376265, 4783.904321913542, 5030.924536131961, 5036.11867923112, 5042.899142017139, 5043.420006699203, 5093.23601459784, 4838.274258861199, 4913.0, 4915.680480768739, 4979.47715489872, 5045.117104506697, 4613.723176609415, 4635.605973492224, 4646.976765116153, 4648.581627653527, 4663.114008338405, 5070.087384270793, 5087.6947383156385, 5090.211017292326, 5091.872703182376, 5091.87270318245, 4862.78117484714, 4896.706197628154, 4903.01939612079, 4905.068037072945, 4907.803687852517, 4978.153713868651, 4978.701277923336, 4979.05397974391, 4984.028114517634, 4987.0, 4731.006488637425, 4902.093112774148, 4965.4041515018425, 5023.0, 5032.169692000779, 4946.060248552763, 4946.554810067111, 4948.480409556944, 4951.653384263067, 5011.924821127686, 4217.8523751668545, 4220.493540775126, 4264.701470897069, 4269.743815371087, 4269.914601707948, 3598.5501812273465, 3600.0819790953665, 3625.12996880752, 3630.437282221207, 3670.44943258508, 4344.044310251739, 4370.409994650745, 4371.497277813092, 4414.205443020223, 4414.646828253732, 5048.646594738407, 5051.217061355495, 5051.267566202953, 5054.115529782273, 5099.209622508517, 4259.1268789897995, 4306.031142992864, 4355.760433176206, 4362.629176519968, 4408.140412619572, 4455.0, 4463.218936686067, 4500.234960056799, 4501.122281155143, 4574.08518296342, 4710.764461776966, 4718.433787945469, 4723.551262630044, 4730.030343779448, 4783.856484305337, 4885.682430641997, 5048.621353398436, 5049.596032317332, 5054.393472783289, 5114.309568208244, 4643.187442197534, 4695.859124226278, 4707.176244157327, 4715.269133284346, 4716.056788642217, 4871.805127794849, 4924.4090709115135, 4924.507549245047, 4925.950740492549, 4930.063287975273, 4968.3292755479, 4988.27669987857, 4998.60011199096, 4999.550040496373, 5010.398752149766, 4835.105505481497, 4868.561829435368, 4874.317595536557, 4874.463808981081, 4874.756262186947, 4852.369192005017, 4855.028994201103, 4896.461389247252, 4954.950450495593, 4958.801647934042, 4819.036192761391, 4819.975900120477, 4828.251620998751, 4836.806527738851, 4893.119238537098, 4752.714837109785, 4803.855884323476, 4927.088488629615, 4932.556069953722, 4979.875503112451, 4761.166795810788, 4795.376601041982, 4809.182438985311, 4821.879453013703, 4865.1485989952325], "value": 4590.596066974087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2883986397751, 556.499150764312, 586.437020460358, 598.2701104652325, 606.4632799972023, 27391.04131355403, 37261.25477490452, 38661.613383866184, 38662.420063699064, 43148.35277470841, 39946.40080398796, 40456.39315410271, 40466.59533404665, 40521.0, 40538.0, 7611.238876112386, 7741.0, 7748.41886858485, 7763.146053934062, 7766.922330776676, 7045.4715896307725, 7324.414046876237, 9666.758331041745, 9953.751156221117, 9969.50152492376, 9939.602415903355, 10012.89987100127, 10029.448380339078, 10034.197264218845, 10041.548130334117, 9986.550605222783, 10008.349457285252, 10022.0, 10057.195424366033, 10071.597136114546, 9763.170130538912, 9884.456354900478, 9890.30767846251, 9891.159251463634, 9891.208703303719, 37831.432528512094, 38082.0, 38119.428208576894, 38138.80930595329, 38188.61811381878, 3051.25244315142, 3137.8117312961294, 3225.580674512322, 3325.5676762021026, 3386.356592247465, 27314.726852731415, 28014.439711205865, 28044.859775700992, 28047.439051218862, 28119.85940070307, 3152.5271209318557, 3387.4749413840896, 3488.372093023255, 3508.8070156141403, 3517.7889326640484, 242714.0, 242902.0, 246926.0, 247184.76407618026, 247411.0, 28466.430671386457, 50492.74753626208, 50945.0, 50951.74524127356, 50986.74506627517, 30132.54801177984, 32100.35799284048, 32225.677743222735, 32236.0, 32290.515642265385, 13063.934680326727, 13265.66835829112, 13268.601941941757, 13280.468781248836, 13287.468501260035, 9073.54632268384, 10179.796404071878, 10189.082982531607, 10193.286469947032, 10198.33710808795, 7182.102237220348, 18309.267629294944, 18878.716819247722, 19218.807811921983, 19834.60330793405, 6889.242183359826, 6935.375816176568, 7009.404200642901, 7117.89323160153, 7202.819929501804, 780.5082797837326, 898.3531857062904, 940.4639355567261, 946.7396465971913, 975.4050029482011, 26395.340116497242, 27610.171694849185, 28542.0, 30021.39957200844, 30553.0, 926.9490178040138, 958.5255298627085, 973.7955029443896, 1000.7798284377425, 1050.6847945616437, 14127.15237085778, 15025.924870375578, 16001.199940002953, 16122.0, 16615.41846035383, 380917.0, 383562.0, 383881.0, 386097.0, 386383.0, 49022.509774901795, 49425.0, 49460.75269623701, 49535.0, 49626.0, 1093.3330668292335, 1107.894749998749, 1111.09445801673, 1183.7099910521806, 1196.4376742930808, 26387.60418593761, 28347.85826070939, 29031.564526531696, 30842.537361940038, 31588.684113159492, 45149.0, 45947.0, 45996.54003460056, 46056.0, 46067.30899036584, 267716.0, 267858.0, 268130.0, 268281.0, 268786.0, 24558.263252102464, 24931.875340623905, 25350.74649253484, 31267.53098703567, 32587.674123259414, 41411.0, 42292.501974744315, 42800.357994629485, 43238.78380608077, 47279.29081063856, 35611.82194089013, 35937.0, 36108.81945590255, 36386.27227455489, 36579.0, 35481.0, 35641.28717425585, 36065.81967090148, 36397.27205455929, 36754.63245367619, 34579.827100864335, 35008.474872877436, 35389.469157962136, 35545.0, 36078.819605902856, 30508.38983220279, 33343.1664208387, 33586.32827343488, 33631.0, 33748.662513374555, 24945.50108997846, 25593.217797283363, 25667.871660641576, 25731.614025790004, 26190.86904565465], "value": 17493.08295543185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.63658884993066, 353.17357383722083, 361.2089523942566, 365.66541614422795, 391.6788233648409, 12162.452689628966, 15862.286197121128, 16330.2651380688, 16642.417515386966, 17605.383811566597, 15643.765343519857, 15666.530004099866, 16101.0, 17013.57466063349, 17137.400190993318, 4049.967258349117, 4844.951550484503, 4973.975130124344, 5015.423226328982, 5065.797368105272, 4860.4896485869, 4947.208446648537, 4948.901021979558, 4949.208126699728, 4950.950490495103, 4815.085133824579, 4848.054629347279, 4889.095517329288, 4918.754062296889, 4925.852224433273, 4918.803247870081, 4976.4277108132665, 4978.502149785028, 4979.875503112415, 4984.700917944917, 4269.935950960738, 4375.0812329410865, 4470.508244093147, 4472.217361961643, 4474.082813023322, 18763.718544221847, 19600.607987840165, 20326.695099573517, 20461.590768184702, 20479.28322508705, 1802.0352632785523, 1810.7464954906325, 1841.2542920117373, 1877.11775465531, 1947.123794292574, 8428.261863581267, 8635.309175266026, 8847.77880552985, 9068.183863452256, 9181.403208791407, 1668.1825905306434, 1748.9300427982866, 1752.570620198047, 1792.2830867652913, 1801.7837859456818, 65540.67229663869, 66459.66770166118, 66940.0, 69904.3009569908, 71732.28267717308, 9512.42925424463, 9685.757856053655, 9722.416655000723, 9866.654667086617, 9940.751481212883, 13571.59285221445, 13571.59285221445, 13584.252866092262, 13621.863781362059, 13622.591322260349, 6863.416609588241, 7050.378412964944, 7188.706032914126, 7192.318068725648, 7292.598907060163, 6801.931980680229, 6823.1812182538415, 6992.965035174791, 7001.229864714877, 7016.087908571955, 4070.3745296215325, 4168.979155104265, 4171.83312667496, 4227.8097485613225, 4333.58830911063, 1640.9015459072493, 1809.3848091648902, 1820.7359932809668, 1845.8246466585654, 1860.6185731924922, 804.8028233082932, 808.846319199362, 837.2715737308581, 838.3754103193038, 887.7248053103558, 16341.673166536602, 16526.256318465697, 16963.406280780113, 17109.23008464622, 17414.0, 827.9503229806231, 833.954132522717, 842.4776638484057, 847.5084451018395, 906.6282824042243, 8821.779455513535, 8996.190342869173, 9563.282753793494, 9598.42409455421, 9790.657326993522, 343121.0, 349730.0, 353313.0, 364941.0, 365107.0, 75481.62259188668, 75698.62150689322, 78343.21656783359, 78733.21266787259, 78935.0, 876.5266755951842, 880.0451510111473, 899.5412339706666, 903.4037535226719, 903.9728808135767, 14589.343479543233, 14817.851821482078, 14966.251687415368, 15274.465393711167, 15483.922580387027, 36151.0, 37021.6297837029, 37034.8148259257, 37145.6285437153, 37893.24213515659, 49195.754021229666, 49552.0, 50294.24558631697, 50340.49659503358, 50636.493635063176, 7358.448116391399, 7557.244275572619, 7697.081324747853, 7835.647395867314, 8094.83810323802, 11703.531858725897, 12049.759004820029, 12071.215371000857, 12251.326177059991, 12310.199837010565, 9795.914286999572, 10330.638427654996, 10602.257841951297, 10642.8935710645, 10993.450327483753, 10373.377597344184, 10469.581216751245, 10563.15494760402, 10609.734756631146, 10926.945365273123, 7107.933809928552, 10505.9474702626, 10512.26414151002, 10629.787404251718, 10795.19036072282, 7797.337226335825, 7948.841023179389, 7956.0, 8091.1504292048485, 8174.550399727834, 8775.473471591726, 10573.207009474167, 10583.841242381524, 10619.256652034283, 10971.396573188233], "value": 7977.4203703740195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.250745806245, 1313.632182988763, 1376.236188915152, 1411.9435222591096, 1691.8139004709487, 6684.866302673943, 7206.531575447599, 7464.29089236523, 7760.068791744999, 7778.8833167502535, 7790.727324543642, 7846.489978151416, 7849.8037549061155, 7849.921500784991, 7861.449698521092, 2120.480482281839, 2139.208492857637, 2141.9357419277367, 2142.2180903970016, 2144.345974477784, 2074.408793493855, 2123.2462475821094, 2149.269248455525, 2154.762976072631, 2160.5786871560053, 2111.292716939827, 2128.7871212878667, 2136.75427325858, 2148.6347320955474, 2155.9784402155933, 2020.4140799168224, 2027.0979414160704, 2031.2281333093479, 2033.3493282149718, 2036.5112373030365, 1996.6306233346877, 2068.038362161587, 2068.9482762930897, 2070.834333253336, 2072.471519762466, 7822.491538050009, 7851.528908265465, 7908.406869484812, 7914.169012253688, 7921.603919804044, 4439.178751930871, 4599.034202817379, 4601.677882548223, 4640.721556706575, 4651.534846515356, 2703.9324016899536, 2827.5475923852086, 2848.401835614503, 2874.2383268433673, 2878.424315136981, 867.7526904832156, 872.6683860133172, 877.1929824561419, 884.3102380143498, 886.0784783824814, 9777.804443911082, 9890.554925028391, 9900.80198396028, 9906.950465247699, 9912.0, 3620.855165793339, 3629.872954446582, 3788.45067465216, 3814.3324918139215, 3819.427085937132, 7954.602269886483, 7974.720884769005, 7976.0, 7976.641051152712, 8004.07953085391, 4359.2807186813825, 4372.300431930876, 4375.037491751809, 4378.321360189176, 4384.605385515319, 3547.5742910850345, 3661.707063434919, 4001.4598029265676, 4065.573114822901, 4081.0, 3234.450143475615, 3278.491953655408, 3368.4105281575626, 3415.777974431654, 3421.5723034620673, 937.5593471068587, 941.7786820097272, 949.7055912667096, 972.8929817720186, 985.1380042462845, 798.6525861250375, 822.1285437436337, 837.8491871463195, 842.1536355962219, 845.9746207613781, 5076.543111119943, 5330.573554115662, 5468.343798744176, 5539.2522009529, 5559.359988803232, 789.1083076123944, 795.7851380127333, 831.2892476932136, 833.1127349372898, 843.1821133500495, 3344.8494817733263, 3451.4995325677637, 3694.3350196964266, 3715.1269451678836, 3723.4414837774007, 9466.95266523663, 9819.214462843098, 9904.0, 9928.255380846465, 9932.404055756533, 9749.366291191192, 9831.852522212173, 9878.753031174134, 9888.752781180528, 9902.564128201371, 6997.615131167835, 7171.533850299714, 7281.745138920219, 7297.270272972554, 7297.781066567905, 5065.29995059457, 5231.032259032091, 5240.187770895517, 5325.121354976541, 5465.316835395575, 9039.68361107358, 9116.270698343984, 9127.543622818965, 9128.224100951493, 9140.771480713036, 8542.530160840965, 8883.0, 8883.156100170732, 9110.180083792491, 9185.311101667268, 6052.757889684363, 6241.594296370721, 6717.496187785838, 6876.69054892521, 6887.104676392037, 7251.56490610565, 7426.814329641802, 7511.8497630046, 7703.152653208031, 7718.228177182237, 6731.259561448139, 6901.930980690129, 6904.206016308189, 6923.411510021705, 7068.893966590608, 6717.227518835396, 6727.629980350932, 6748.392644661808, 6795.0, 6926.722931082701, 6127.816165515042, 6217.96891015542, 6221.9377806223165, 6231.844203894758, 6235.96882015587, 4505.909881802411, 4613.215753321876, 4633.119707255745, 4660.557247061523, 4673.883152921204, 4674.672772905864, 4819.180739274402, 4890.364252647133, 4899.118158731462, 4985.202367621163], "value": 4026.4431280886547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.73197534440897, 278.2473409427499, 288.72138386457067, 291.072932709321, 296.96881827408123, 4688.578027977482, 4787.784549695263, 4812.195426714982, 4865.294532292815, 4865.878353041171, 4630.467496237934, 4783.689060211083, 4784.545468180526, 4791.664583479158, 4839.612830973522, 3838.86753407744, 3849.7690138591634, 3859.3053250414914, 3860.806959652013, 3864.555576108741, 3532.4701294805727, 3547.3260080584737, 3831.1954489557224, 3852.9807350963206, 3854.614538546137, 3669.5138468919995, 3699.4450832375223, 3712.0719820044988, 3713.294474049935, 3721.6836568891677, 3703.3148867459604, 3706.5737440194316, 3712.832922518493, 3726.1802403471193, 3728.6017743346247, 3251.1872031992, 3256.755743319237, 3257.8696852125886, 3260.7065364117343, 3266.96733032669, 4584.724916504987, 4660.650451216173, 4681.859544213679, 4683.180443422388, 4687.742174180418, 4279.122779830159, 4296.677749168824, 4296.73246392315, 4304.461942257218, 4305.4715575970395, 4989.625778066623, 5014.0723966066025, 5017.5985921126585, 5048.7728052237735, 5065.240213967897, 3426.7429942754393, 3516.982415087934, 3641.0, 3644.398674218751, 3649.543807024122, 5157.616026377586, 5169.198774189969, 5220.4257531671865, 5222.6605270657665, 5224.4775522447835, 3590.5870824855474, 3607.3506768781344, 3611.6930060944587, 3614.855405783739, 3624.6737793598704, 3651.2514934438377, 3655.744097913174, 3663.19409729859, 3680.9631903681156, 3694.891532540227, 4036.414719865603, 4189.958100419018, 4203.0, 4210.915781684349, 4239.851605193803, 4964.478729733398, 4968.478309777493, 4995.275685025724, 4996.275540046673, 5011.473795251519, 1206.8732783057653, 1241.2862604002735, 1258.7356655102349, 1274.5602767045355, 1292.6509842342703, 892.8437523433373, 914.2000749344323, 919.3151102428733, 924.117467818232, 928.0626567167075, 4432.977835110803, 4440.911181776411, 4450.821967121279, 4459.1973444779605, 4483.910321793546, 5112.0, 5125.743712814345, 5134.5378915897745, 5147.3051138096625, 5148.510891465305, 4296.0, 4540.409746732969, 4561.817527298871, 4565.79006563261, 4571.994161284512, 2747.8763455644144, 2758.3931535062256, 2782.5687018512162, 2790.772060293464, 2792.2460935547288, 4711.293306004059, 4843.934334446416, 4847.0, 4878.463369029404, 4900.534449227318, 5246.921296180561, 5253.55344795689, 5270.181787283381, 5275.20871869215, 5291.814786482455, 4828.975855120772, 4839.806407743721, 4845.466998630148, 4859.95140048595, 4864.659473836798, 4980.228064649985, 5090.898182036412, 5127.256547800623, 5130.921447131691, 5149.176131818891, 4980.302757614009, 5009.298698182184, 5037.395512538372, 5038.1435156022835, 5041.949580504148, 4802.73584952831, 4848.151573474698, 4854.781534831011, 4861.204807235783, 4867.683600565952, 3542.326957877995, 3626.111602657366, 3631.219287853124, 3631.5279013729105, 3646.34365814156, 5082.695038297714, 5107.872303192301, 5122.462141475092, 5138.409082955508, 5140.177571588528, 4967.7019378837385, 4978.610267071754, 4990.6007519397635, 4991.425986011655, 4994.575461085703, 4769.2130798417875, 4995.8001679932395, 5000.000000000087, 5010.69935803853, 5063.860631357915, 4650.9767451162525, 4720.716756994591, 4820.590249828804, 4907.779149938333, 4922.1140194765285, 5021.924671129863, 5024.924626130538, 5047.460524540051, 5049.823256186163, 5068.771905264198, 4938.654294199371, 4944.48082951285, 4945.282933974481, 4969.204927211774, 4979.427365852828], "value": 3777.6120931014993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6830663901451, 613.1660941120078, 643.630593841241, 700.4711442860639, 708.6952610377539, 13361.933190334046, 14159.22124283164, 14168.0, 14171.645708857284, 14178.432862685493, 13227.801582976263, 13372.531961381354, 13393.866061339384, 13409.396577154028, 13416.060875738678, 613.7882430561449, 630.7697690343037, 709.9077119974409, 729.4966473133547, 754.6566312327877, 764.652083302099, 779.4504874063799, 779.9415043871733, 780.2509590792846, 781.281221276427, 835.9456635318716, 838.2372041442288, 838.4927119092953, 838.7567605394428, 839.3117643532306, 655.0698008827476, 672.868790585836, 787.8030492376906, 830.3108420011406, 830.3523251863526, 591.7189335065852, 594.4738906068118, 595.2143171014263, 595.3064679648205, 595.5354823237838, 13486.865131348659, 13511.459541618324, 13528.32358382077, 13530.120542164728, 13535.526256581072, 11987.820182697267, 12056.63830085099, 12110.333931633757, 12374.938125309316, 12803.743925121445, 10510.894891051068, 10526.42104684242, 10557.0, 10656.840147397796, 10853.620123295646, 3745.606711295302, 3785.242951409729, 3820.694344452465, 3894.9221015579815, 3901.8049097545295, 59396.40603593952, 59415.40584594142, 59809.10286345752, 60265.69867150636, 61146.694266528386, 8914.465132092095, 9081.364304498622, 9257.953710231406, 9265.95367023174, 9304.95347523258, 17844.840085394666, 17869.46391608254, 18050.27798888056, 18099.366522171662, 18110.818891811177, 6304.961337969133, 6306.463950564162, 6378.362163783678, 6395.296517383084, 6486.805395838132, 3499.33512632599, 3513.9648603514147, 3514.7363947704025, 3524.8413821377585, 3562.2341196642847, 2793.8184018038764, 2922.6346706661666, 2926.239177813784, 2930.6483222013067, 2936.6769655337894, 481.6556162343871, 483.53097495429375, 483.5527137397893, 484.0826633529442, 494.9331840201527, 411.8085090432963, 481.97590120493834, 484.32194927101636, 484.9927251091236, 504.6164914664881, 6830.931690683129, 7064.32888875556, 7524.661390237453, 7588.241175882367, 7912.802179945433, 516.2127755173316, 518.4970578538812, 561.8342588936274, 570.1248583424424, 576.3400905962649, 3558.697510711567, 3584.713222942158, 3642.399004164336, 3785.6592906638534, 3810.371288737327, 92301.0, 97460.0, 97555.51222243844, 97677.51161244148, 99316.50341748245, 67318.32681673218, 71270.0, 78702.6064869672, 79252.0, 85079.5746021266, 67714.66142669255, 68058.31941680619, 69800.30199697938, 72252.43960966221, 72339.0, 8023.277904988579, 8396.538190399342, 8810.735677929672, 8847.20375166238, 8937.329700272636, 38620.944800796635, 41665.37501937534, 41983.790081049396, 42263.99999999877, 43391.34912976371, 55262.0, 56853.0, 62605.0, 63943.360566395604, 64774.35225647872, 11048.613298534512, 11052.557897684324, 11111.611093611686, 11250.324980501196, 11613.245139065933, 11620.88379116198, 11919.582814601446, 12043.698907527381, 13023.934880325538, 13057.608271751862, 11715.707107322385, 11771.293722376684, 12124.515019399125, 12340.444679989601, 12582.685432864251, 11453.59912403062, 11578.94210528942, 11829.053675706095, 12200.206986545845, 12240.387980600755, 11294.43527823622, 11311.151663625096, 11759.529618815151, 11765.823512647488, 12137.635870923887, 9329.953350233205, 9754.75613109678, 9953.900460995297, 10095.949520252645, 10426.582936682447, 8818.470891746516, 10260.948695256775, 10356.792864142524, 10365.533550990072, 10382.896171038496], "value": 6383.651695262233, "unit": "score"}], "name": "dromaeo_css", "value": 6294.715844674512, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 117.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 127.0, 175.0, 133.0, 134.0, 136.0, 127.0, 166.0, 129.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 161.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 77.0, 79.0, 77.0, 78.0, 99.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 118.0, 83.0, 84.0, 83.0, 104.0, 83.0, 83.0, 114.0], "value": 92.0, "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, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 70.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 83.0, 83.0, 86.0, 83.0, 94.0, 84.0, 83.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 140.0, 139.0, 141.0, 146.0, 150.0, 141.0, 140.0, 182.0, 139.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 178.0, 184.0, 182.0, 189.0, 185.0, 186.0, 177.0, 176.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 72.0, 72.0, 71.0, 71.0, 73.0, 71.0, 70.0, 70.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1567.3, "alertThreshold": 2.0}]} 12:40:01 INFO - Return code: 0 12:40:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:40:01 INFO - # TBPL SUCCESS # 12:40:01 INFO - Running post-action listener: _resource_record_post_action 12:40:01 INFO - [mozharness: 2016-10-04 19:40:01.105331Z] Finished run-tests step (success) 12:40:01 INFO - Running post-run listener: _resource_record_post_run 12:40:01 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404148224; Read time: 20; Write time: 253448 12:40:01 INFO - TinderboxPrint: CPU usage
13.0% 12:40:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 12:40:01 INFO - TinderboxPrint: I/O write bytes / time
404,148,224 / 253,448 12:40:01 INFO - TinderboxPrint: CPU idle
8,355.4 (87.0%) 12:40:01 INFO - TinderboxPrint: CPU user
1,203.0 (12.5%) 12:40:01 INFO - TinderboxPrint: Swap in / out
0 / 0 12:40:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110600192; Read time: 0; Write time: 61852 12:40:01 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293548032; Read time: 0; Write time: 191596 12:40:01 INFO - Running post-run listener: _upload_blobber_files 12:40:01 INFO - Blob upload gear active. 12:40:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:01 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 12:40:01 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:40:01 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:40:02 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:02 INFO - (blobuploader) - INFO - Done attempting. 12:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:40:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:06 INFO - (blobuploader) - INFO - Done attempting. 12:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:07 INFO - (blobuploader) - INFO - Done attempting. 12:40:07 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:07 INFO - Return code: 0 12:40:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/422692a064be243a09be34dc7678073c398b7cbe8ca9f6adb2cd83c674ee7b8f39a035dbc4bb1679c5eb81ef6e894d5012b51a0ca447620a4fb03ab7f5a16777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf92c5892605e025351c07b451fc5048a59d1233e3b61fe0baa70fbd0bb429c297d22695162b69683b5b8d19588801ba22891534b39e8eb899b32fff47b4501b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b64d4c4385b55044054e6d348cfad1cb56fdfff9f1e5d0c8052256c112be1e248b57880d69ef4c93a67f76553628271e7d88615d3b23422c434fcb4d367cd5"} 12:40:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:07 INFO - Contents: 12:40:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/422692a064be243a09be34dc7678073c398b7cbe8ca9f6adb2cd83c674ee7b8f39a035dbc4bb1679c5eb81ef6e894d5012b51a0ca447620a4fb03ab7f5a16777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf92c5892605e025351c07b451fc5048a59d1233e3b61fe0baa70fbd0bb429c297d22695162b69683b5b8d19588801ba22891534b39e8eb899b32fff47b4501b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b64d4c4385b55044054e6d348cfad1cb56fdfff9f1e5d0c8052256c112be1e248b57880d69ef4c93a67f76553628271e7d88615d3b23422c434fcb4d367cd5"} 12:40:07 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:07 INFO - Copying logs to upload dir... 12:40:07 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.642632 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 12:40:06.185169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 12:40:06.189135) ========= 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=6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/422692a064be243a09be34dc7678073c398b7cbe8ca9f6adb2cd83c674ee7b8f39a035dbc4bb1679c5eb81ef6e894d5012b51a0ca447620a4fb03ab7f5a16777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf92c5892605e025351c07b451fc5048a59d1233e3b61fe0baa70fbd0bb429c297d22695162b69683b5b8d19588801ba22891534b39e8eb899b32fff47b4501b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b64d4c4385b55044054e6d348cfad1cb56fdfff9f1e5d0c8052256c112be1e248b57880d69ef4c93a67f76553628271e7d88615d3b23422c434fcb4d367cd5"} build_url:https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/f1nl5tJfQ7-jA9rWRyc86w/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/Fx-Team-Non-PGO/sha512/422692a064be243a09be34dc7678073c398b7cbe8ca9f6adb2cd83c674ee7b8f39a035dbc4bb1679c5eb81ef6e894d5012b51a0ca447620a4fb03ab7f5a16777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf92c5892605e025351c07b451fc5048a59d1233e3b61fe0baa70fbd0bb429c297d22695162b69683b5b8d19588801ba22891534b39e8eb899b32fff47b4501b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b64d4c4385b55044054e6d348cfad1cb56fdfff9f1e5d0c8052256c112be1e248b57880d69ef4c93a67f76553628271e7d88615d3b23422c434fcb4d367cd5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 12:40:06.215052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:40:06.215422) ========= 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=6dbc10da6d83fee962c624be000001a8-1475605105.663470-603857426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 12:40:06.300912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 12:40:06.301254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 12:40:06.301580) ========= ========= Total master_lag: 0.18 =========