builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1475619277.48 results: success (0) buildid: 20161004123000 builduid: d2a644ad44414a7fa15f52adec43eadd revision: ad324639bfaeba6d7be3b732295b6a27d0c54e0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.484586) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.485079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.485434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.500113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.500483) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 15:14:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-10-04 15:14:38 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102646 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.924443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.924820) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014990 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.956468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:37.956875) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 15:14:38,482 truncating revision to first 12 chars 2016-10-04 15:14:38,482 Setting DEBUG logging. 2016-10-04 15:14:38,482 attempt 1/10 2016-10-04 15:14:38,482 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 15:14:38,833 unpacking tar archive at: fx-team-ad324639bfae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:38.660036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:38.660468) ========= script_repo_revision: ad324639bfaeba6d7be3b732295b6a27d0c54e0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:38.660974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:38.661753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 15:14:38.672612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-04 15:14:38.672953) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:39 INFO - MultiFileLogger online at 20161004 15:14:39 in /builds/slave/test 15:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:14:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:39 INFO - {'append_to_log': False, 15:14:39 INFO - 'base_work_dir': '/builds/slave/test', 15:14:39 INFO - 'blob_upload_branch': 'Fx-Team', 15:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:39 INFO - 'branch': 'Fx-Team', 15:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:39 INFO - 'config_files': ('talos/linux_config.py',), 15:14:39 INFO - 'default_actions': ('clobber', 15:14:39 INFO - 'read-buildbot-config', 15:14:39 INFO - 'download-and-extract', 15:14:39 INFO - 'populate-webroot', 15:14:39 INFO - 'create-virtualenv', 15:14:39 INFO - 'install', 15:14:39 INFO - 'run-tests'), 15:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:39 INFO - 'download_minidump_stackwalk': True, 15:14:39 INFO - 'download_symbols': 'ondemand', 15:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:39 INFO - 'installer_path': 'installer.exe', 15:14:39 INFO - 'log_level': 'info', 15:14:39 INFO - 'log_name': 'talos', 15:14:39 INFO - 'log_to_console': True, 15:14:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:39 INFO - 'opt_config_files': (), 15:14:39 INFO - 'pip_index': False, 15:14:39 INFO - 'sps_profile': False, 15:14:39 INFO - 'sps_profile_interval': 0, 15:14:39 INFO - 'suite': 'dromaeojs', 15:14:39 INFO - 'system_bits': '32', 15:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:39 INFO - 'title': 'talos-linux64-ix-039', 15:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:39 INFO - 'use_talos_json': True, 15:14:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:39 INFO - 'work_dir': 'build'} 15:14:39 INFO - [mozharness: 2016-10-04 22:14:39.296377Z] Running clobber step. 15:14:39 INFO - Running pre-action listener: _resource_record_pre_action 15:14:39 INFO - Running main action method: clobber 15:14:39 INFO - rmtree: /builds/slave/test/build 15:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:39 INFO - Running post-action listener: _resource_record_post_action 15:14:39 INFO - [mozharness: 2016-10-04 22:14:39.773467Z] Finished clobber step (success) 15:14:39 INFO - [mozharness: 2016-10-04 22:14:39.773568Z] Running read-buildbot-config step. 15:14:39 INFO - Running pre-action listener: _resource_record_pre_action 15:14:39 INFO - Running main action method: read_buildbot_config 15:14:39 INFO - Using buildbot properties: 15:14:39 INFO - { 15:14:39 INFO - "project": "", 15:14:39 INFO - "product": "firefox", 15:14:39 INFO - "script_repo_revision": "production", 15:14:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:14:39 INFO - "repository": "", 15:14:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:14:39 INFO - "buildid": "20161004123000", 15:14:39 INFO - "pgo_build": "True", 15:14:39 INFO - "basedir": "/builds/slave/test", 15:14:39 INFO - "buildnumber": 501, 15:14:39 INFO - "slavename": "talos-linux64-ix-039", 15:14:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:14:39 INFO - "platform": "ubuntu64_hw", 15:14:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:14:39 INFO - "branch": "fx-team", 15:14:39 INFO - "repo_path": "integration/fx-team", 15:14:39 INFO - "revision": "ad324639bfaeba6d7be3b732295b6a27d0c54e0a", 15:14:39 INFO - "stage_platform": "linux64-pgo", 15:14:39 INFO - "builduid": "d2a644ad44414a7fa15f52adec43eadd", 15:14:39 INFO - "slavebuilddir": "test" 15:14:39 INFO - } 15:14:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:14:39 INFO - Running post-action listener: _resource_record_post_action 15:14:39 INFO - [mozharness: 2016-10-04 22:14:39.775995Z] Finished read-buildbot-config step (success) 15:14:39 INFO - [mozharness: 2016-10-04 22:14:39.776083Z] Running download-and-extract step. 15:14:39 INFO - Running pre-action listener: _resource_record_pre_action 15:14:39 INFO - Running main action method: download_and_extract 15:14:39 INFO - mkdir: /builds/slave/test/build/tests 15:14:39 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')]} 15:14:39 INFO - trying https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:14:39 INFO - Downloading https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/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 15:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/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 15:14:40 INFO - Downloaded 1361 bytes. 15:14:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:14:40 INFO - Using the following test package requirements: 15:14:40 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:14:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:14:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'jsshell-linux-x86_64.zip'], 15:14:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:14:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:14:40 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:14:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:14:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:14:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:14:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:14:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:40 INFO - Fetch https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:14:40 INFO - Http code: 200 15:14:40 INFO - via: 1.1 f46e4d7bc5419470a70eb57aa9c935c8.cloudfront.net (CloudFront) 15:14:40 INFO - x-amz-cf-id: 1V5GfYjJWP2dv9g7o87NbE6cTyb7uxxkn_cFaE000kWYJ5J7TOsvnA== 15:14:40 INFO - x-amz-version-id: kPDtRDvlt_JxvcJhzXVB4tBE2PXgIssf 15:14:41 INFO - Expected file size: 21992595 15:14:41 INFO - Obtained file size: 21992595 15:14:45 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 15:14:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:14:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:45 INFO - Fetch https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:14:45 INFO - Http code: 200 15:14:45 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 15:14:45 INFO - x-amz-cf-id: IIBaL6TxyaM2AFVmFXHBBQfzPIZtqGexIxJhBzYtCsduLa3JvTf2ig== 15:14:45 INFO - x-amz-version-id: kPDtRDvlt_JxvcJhzXVB4tBE2PXgIssf 15:14:46 INFO - Expected file size: 21992595 15:14:46 INFO - Obtained file size: 21992595 15:14:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:14:50 INFO - Fetch https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:14:51 INFO - Http code: 200 15:14:51 INFO - via: 1.1 ff09df097f823b2834408d17e9779d62.cloudfront.net (CloudFront) 15:14:51 INFO - x-amz-cf-id: RwGOX1G6u2PTzHOiMPLivu6QocRx0Ez9CQO-z1wnno8ofaLBkXkKMA== 15:14:51 INFO - x-amz-version-id: q5pZcFjsxx6pI.tzquUNmeb5YqippWek 15:14:51 INFO - Expected file size: 14409006 15:14:51 INFO - Obtained file size: 14409006 15:14:51 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')]} 15:14:51 INFO - trying https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:14:51 INFO - Downloading https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/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 15:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/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 15:14:53 INFO - Downloaded 59704453 bytes. 15:14:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:14:53 INFO - mkdir: /builds/slave/test/properties 15:14:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:14:53 INFO - Writing to file /builds/slave/test/properties/build_url 15:14:53 INFO - Contents: 15:14:53 INFO - build_url:https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:14:54 INFO - Running post-action listener: _resource_record_post_action 15:14:54 INFO - Running post-action listener: set_extra_try_arguments 15:14:54 INFO - [mozharness: 2016-10-04 22:14:54.669581Z] Finished download-and-extract step (success) 15:14:54 INFO - [mozharness: 2016-10-04 22:14:54.669807Z] Running populate-webroot step. 15:14:54 INFO - Running pre-action listener: _resource_record_pre_action 15:14:54 INFO - Running main action method: populate_webroot 15:14:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:14:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:14:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:14:54 INFO - '--tppagecycles', 15:14:54 INFO - '7'], 15:14:54 INFO - 'tests': ['tsvgm']}}, 15:14:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:14:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:14:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:14:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:14:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['damp', 'tps']}, 15:14:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'tests': ['damp', 'tps']}, 15:14:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['dromaeo_dom']}, 15:14:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:14:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['basic_compositor_video']}, 15:14:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:14:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['a11yr', 15:14:54 INFO - 'ts_paint', 15:14:54 INFO - 'tpaint', 15:14:54 INFO - 'sessionrestore', 15:14:54 INFO - 'sessionrestore_no_auto_restore', 15:14:54 INFO - 'tabpaint']}, 15:14:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:14:54 INFO - 'ts_paint', 15:14:54 INFO - 'tpaint', 15:14:54 INFO - 'sessionrestore', 15:14:54 INFO - 'sessionrestore_no_auto_restore', 15:14:54 INFO - 'tabpaint']}, 15:14:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:14:54 INFO - 'ts_paint', 15:14:54 INFO - 'tpaint', 15:14:54 INFO - 'sessionrestore', 15:14:54 INFO - 'sessionrestore_no_auto_restore', 15:14:54 INFO - 'tabpaint']}, 15:14:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:14:54 INFO - 'ts_paint', 15:14:54 INFO - 'tpaint', 15:14:54 INFO - 'sessionrestore', 15:14:54 INFO - 'sessionrestore_no_auto_restore', 15:14:54 INFO - 'tabpaint']}, 15:14:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['a11yr', 15:14:54 INFO - 'ts_paint', 15:14:54 INFO - 'tpaint', 15:14:54 INFO - 'sessionrestore', 15:14:54 INFO - 'sessionrestore_no_auto_restore', 15:14:54 INFO - 'tabpaint']}, 15:14:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['a11yr', 15:14:54 INFO - 'ts_paint', 15:14:54 INFO - 'tpaint', 15:14:54 INFO - 'sessionrestore', 15:14:54 INFO - 'sessionrestore_no_auto_restore', 15:14:54 INFO - 'tabpaint']}, 15:14:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['tsvgx', 15:14:54 INFO - 'tsvgr_opacity', 15:14:54 INFO - 'tart', 15:14:54 INFO - 'tscrollx', 15:14:54 INFO - 'cart']}, 15:14:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:14:54 INFO - 'tsvgr_opacity', 15:14:54 INFO - 'tart', 15:14:54 INFO - 'tscrollx', 15:14:54 INFO - 'cart']}, 15:14:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'talos_options': ['--disable-e10s'], 15:14:54 INFO - 'tests': ['tp5o']}, 15:14:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'tests': ['tp5o']}, 15:14:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'talos_options': ['--disable-e10s', 15:14:54 INFO - '--xperf_path', 15:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:54 INFO - 'tests': ['tp5n']}, 15:14:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:54 INFO - 'talos_options': ['--xperf_path', 15:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:54 INFO - 'tests': ['tp5n']}}, 15:14:54 INFO - 'talos.zip': {'path': '', 15:14:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:14:54 INFO - Running post-action listener: _resource_record_post_action 15:14:54 INFO - [mozharness: 2016-10-04 22:14:54.691091Z] Finished populate-webroot step (success) 15:14:54 INFO - [mozharness: 2016-10-04 22:14:54.691178Z] Running create-virtualenv step. 15:14:54 INFO - Running pre-action listener: _resource_record_pre_action 15:14:54 INFO - Running main action method: create_virtualenv 15:14:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:14:54 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 15:14:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:14:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:14:54 INFO - Using real prefix '/usr' 15:14:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:14:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:57 INFO - Installing pip.................done. 15:14:57 INFO - Return code: 0 15:14:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:14:57 INFO - Reading from file tmpfile_stdout 15:14:57 INFO - Output received: 15:14:57 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) 15:14:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:14:57 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')]} 15:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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')]} 15:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:14:57 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 15:14:57 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 15:14:57 INFO - Using env: {'DISPLAY': ':0', 15:14:57 INFO - 'HOME': '/home/cltbld', 15:14:57 INFO - 'LANG': 'en_US.UTF-8', 15:14:57 INFO - 'LANGUAGE': 'en_US:en', 15:14:57 INFO - 'LOGNAME': 'cltbld', 15:14:57 INFO - 'MAIL': '/var/mail/cltbld', 15:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:57 INFO - 'MOZ_NO_REMOTE': '1', 15:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:57 INFO - 'NO_EM_RESTART': '1', 15:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:57 INFO - 'PWD': '/builds/slave/test', 15:14:57 INFO - 'SHELL': '/bin/bash', 15:14:57 INFO - 'SHLVL': '1', 15:14:57 INFO - 'TERM': 'linux', 15:14:57 INFO - 'TMOUT': '86400', 15:14:57 INFO - 'USER': 'cltbld', 15:14:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:57 INFO - '_': '/tools/buildbot/bin/python'} 15:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:57 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 15:14:57 INFO - Cleaning up... 15:14:57 INFO - Return code: 0 15:14:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:14:57 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')]} 15:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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')]} 15:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:57 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:14:57 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 15:14:57 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 15:14:57 INFO - Using env: {'DISPLAY': ':0', 15:14:57 INFO - 'HOME': '/home/cltbld', 15:14:57 INFO - 'LANG': 'en_US.UTF-8', 15:14:57 INFO - 'LANGUAGE': 'en_US:en', 15:14:57 INFO - 'LOGNAME': 'cltbld', 15:14:57 INFO - 'MAIL': '/var/mail/cltbld', 15:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:57 INFO - 'MOZ_NO_REMOTE': '1', 15:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:57 INFO - 'NO_EM_RESTART': '1', 15:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:57 INFO - 'PWD': '/builds/slave/test', 15:14:57 INFO - 'SHELL': '/bin/bash', 15:14:57 INFO - 'SHLVL': '1', 15:14:57 INFO - 'TERM': 'linux', 15:14:57 INFO - 'TMOUT': '86400', 15:14:57 INFO - 'USER': 'cltbld', 15:14:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:57 INFO - '_': '/tools/buildbot/bin/python'} 15:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:57 INFO - Downloading/unpacking psutil>=3.1.1 15:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:59 INFO - Installing collected packages: psutil 15:14:59 INFO - Running setup.py install for psutil 15:14:59 INFO - building 'psutil._psutil_linux' extension 15:14:59 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 15:15:00 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 15:15:00 INFO - building 'psutil._psutil_posix' extension 15:15:00 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 15:15:00 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 15:15:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:00 INFO - Successfully installed psutil 15:15:00 INFO - Cleaning up... 15:15:00 INFO - Return code: 0 15:15:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:15:00 INFO - Using env: {'DISPLAY': ':0', 15:15:00 INFO - 'HOME': '/home/cltbld', 15:15:00 INFO - 'LANG': 'en_US.UTF-8', 15:15:00 INFO - 'LANGUAGE': 'en_US:en', 15:15:00 INFO - 'LOGNAME': 'cltbld', 15:15:00 INFO - 'MAIL': '/var/mail/cltbld', 15:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:00 INFO - 'MOZ_NO_REMOTE': '1', 15:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:00 INFO - 'NO_EM_RESTART': '1', 15:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:00 INFO - 'PWD': '/builds/slave/test', 15:15:00 INFO - 'SHELL': '/bin/bash', 15:15:00 INFO - 'SHLVL': '1', 15:15:00 INFO - 'TERM': 'linux', 15:15:00 INFO - 'TMOUT': '86400', 15:15:00 INFO - 'USER': 'cltbld', 15:15:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:00 INFO - '_': '/tools/buildbot/bin/python'} 15:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:15:02 INFO - Installing collected packages: mozsystemmonitor 15:15:02 INFO - Running setup.py install for mozsystemmonitor 15:15:02 INFO - Successfully installed mozsystemmonitor 15:15:02 INFO - Cleaning up... 15:15:02 INFO - Return code: 0 15:15:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:02 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:02 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 15:15:02 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 15:15:02 INFO - Using env: {'DISPLAY': ':0', 15:15:02 INFO - 'HOME': '/home/cltbld', 15:15:02 INFO - 'LANG': 'en_US.UTF-8', 15:15:02 INFO - 'LANGUAGE': 'en_US:en', 15:15:02 INFO - 'LOGNAME': 'cltbld', 15:15:02 INFO - 'MAIL': '/var/mail/cltbld', 15:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:02 INFO - 'MOZ_NO_REMOTE': '1', 15:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:02 INFO - 'NO_EM_RESTART': '1', 15:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:02 INFO - 'PWD': '/builds/slave/test', 15:15:02 INFO - 'SHELL': '/bin/bash', 15:15:02 INFO - 'SHLVL': '1', 15:15:02 INFO - 'TERM': 'linux', 15:15:02 INFO - 'TMOUT': '86400', 15:15:02 INFO - 'USER': 'cltbld', 15:15:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:02 INFO - '_': '/tools/buildbot/bin/python'} 15:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:15:02 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 15:15:02 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 15:15:02 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 15:15:02 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 15:15:02 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 15:15:02 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 15:15:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:15:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:15:04 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 15:15:04 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 15:15:04 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 15:15:04 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 15:15:04 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 15:15:04 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 15:15:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:15:05 INFO - warning: no files found matching '*.txt' 15:15:05 INFO - no previously-included directories found matching 'build' 15:15:05 INFO - no previously-included directories found matching 'dist' 15:15:05 INFO - no previously-included directories found matching '.git*' 15:15:05 INFO - Installing collected packages: jsonschema, functools32 15:15:05 INFO - Running setup.py install for functools32 15:15:05 INFO - warning: no files found matching '*.txt' 15:15:05 INFO - no previously-included directories found matching 'build' 15:15:05 INFO - no previously-included directories found matching 'dist' 15:15:05 INFO - no previously-included directories found matching '.git*' 15:15:05 INFO - Successfully installed jsonschema functools32 15:15:05 INFO - Cleaning up... 15:15:05 INFO - Return code: 0 15:15:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:15:05 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')]} 15:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:05 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')]} 15:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:05 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:05 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 15:15:05 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 15:15:05 INFO - Using env: {'DISPLAY': ':0', 15:15:05 INFO - 'HOME': '/home/cltbld', 15:15:05 INFO - 'LANG': 'en_US.UTF-8', 15:15:05 INFO - 'LANGUAGE': 'en_US:en', 15:15:05 INFO - 'LOGNAME': 'cltbld', 15:15:05 INFO - 'MAIL': '/var/mail/cltbld', 15:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:05 INFO - 'MOZ_NO_REMOTE': '1', 15:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:05 INFO - 'NO_EM_RESTART': '1', 15:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:05 INFO - 'PWD': '/builds/slave/test', 15:15:05 INFO - 'SHELL': '/bin/bash', 15:15:05 INFO - 'SHLVL': '1', 15:15:05 INFO - 'TERM': 'linux', 15:15:05 INFO - 'TMOUT': '86400', 15:15:05 INFO - 'USER': 'cltbld', 15:15:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:05 INFO - '_': '/tools/buildbot/bin/python'} 15:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:15:05 INFO - Cleaning up... 15:15:05 INFO - Return code: 0 15:15:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:15:05 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')]} 15:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:05 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')]} 15:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:05 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:05 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 15:15:05 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 15:15:05 INFO - Using env: {'DISPLAY': ':0', 15:15:05 INFO - 'HOME': '/home/cltbld', 15:15:05 INFO - 'LANG': 'en_US.UTF-8', 15:15:05 INFO - 'LANGUAGE': 'en_US:en', 15:15:05 INFO - 'LOGNAME': 'cltbld', 15:15:05 INFO - 'MAIL': '/var/mail/cltbld', 15:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:05 INFO - 'MOZ_NO_REMOTE': '1', 15:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:05 INFO - 'NO_EM_RESTART': '1', 15:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:05 INFO - 'PWD': '/builds/slave/test', 15:15:05 INFO - 'SHELL': '/bin/bash', 15:15:05 INFO - 'SHLVL': '1', 15:15:05 INFO - 'TERM': 'linux', 15:15:05 INFO - 'TMOUT': '86400', 15:15:05 INFO - 'USER': 'cltbld', 15:15:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:05 INFO - '_': '/tools/buildbot/bin/python'} 15:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:05 INFO - Downloading/unpacking blobuploader==1.2.4 15:15:05 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 15:15:05 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 15:15:05 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 15:15:05 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 15:15:05 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 15:15:05 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 15:15:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:15:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:07 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 15:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:15:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:15:08 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 15:15:08 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 15:15:08 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 15:15:08 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 15:15:08 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 15:15:08 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 15:15:08 INFO - Downloading docopt-0.6.1.tar.gz 15:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:15:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:15:08 INFO - Running setup.py install for blobuploader 15:15:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:15:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:15:08 INFO - Running setup.py install for requests 15:15:08 INFO - Running setup.py install for docopt 15:15:09 INFO - Successfully installed blobuploader requests docopt 15:15:09 INFO - Cleaning up... 15:15:09 INFO - Return code: 0 15:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:09 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')]} 15:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:09 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')]} 15:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:09 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:09 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 15:15:09 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 15:15:09 INFO - Using env: {'DISPLAY': ':0', 15:15:09 INFO - 'HOME': '/home/cltbld', 15:15:09 INFO - 'LANG': 'en_US.UTF-8', 15:15:09 INFO - 'LANGUAGE': 'en_US:en', 15:15:09 INFO - 'LOGNAME': 'cltbld', 15:15:09 INFO - 'MAIL': '/var/mail/cltbld', 15:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:09 INFO - 'MOZ_NO_REMOTE': '1', 15:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:09 INFO - 'NO_EM_RESTART': '1', 15:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:09 INFO - 'PWD': '/builds/slave/test', 15:15:09 INFO - 'SHELL': '/bin/bash', 15:15:09 INFO - 'SHLVL': '1', 15:15:09 INFO - 'TERM': 'linux', 15:15:09 INFO - 'TMOUT': '86400', 15:15:09 INFO - 'USER': 'cltbld', 15:15:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:09 INFO - '_': '/tools/buildbot/bin/python'} 15:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:09 INFO - Running setup.py (path:/tmp/pip-1bnoBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:09 INFO - Running setup.py (path:/tmp/pip-cJicM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:09 INFO - Running setup.py (path:/tmp/pip-B8HUnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:09 INFO - Running setup.py (path:/tmp/pip-8b3vRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:09 INFO - Running setup.py (path:/tmp/pip-PjY5LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:09 INFO - Running setup.py (path:/tmp/pip-IBG2wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:09 INFO - Running setup.py (path:/tmp/pip-lDfuZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:09 INFO - Running setup.py (path:/tmp/pip-TkKFMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:09 INFO - Running setup.py (path:/tmp/pip-dbxqZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:09 INFO - Running setup.py (path:/tmp/pip-R6_j3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:10 INFO - Running setup.py (path:/tmp/pip-qg3rVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:10 INFO - Running setup.py (path:/tmp/pip-DYra6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:10 INFO - Running setup.py (path:/tmp/pip-BtydD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:10 INFO - Running setup.py (path:/tmp/pip-dMzglY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:10 INFO - Running setup.py (path:/tmp/pip-B_Lp3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:10 INFO - Running setup.py (path:/tmp/pip-EOO4PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:10 INFO - Running setup.py (path:/tmp/pip-OrESv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:15:10 INFO - Running setup.py install for manifestparser 15:15:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozcrash 15:15:10 INFO - Running setup.py install for mozdebug 15:15:10 INFO - Running setup.py install for mozdevice 15:15:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:15:10 INFO - Running setup.py install for mozfile 15:15:11 INFO - Running setup.py install for mozhttpd 15:15:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Running setup.py install for mozinfo 15:15:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Running setup.py install for mozInstall 15:15:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Running setup.py install for mozleak 15:15:11 INFO - Running setup.py install for mozlog 15:15:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Running setup.py install for moznetwork 15:15:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Running setup.py install for mozprocess 15:15:11 INFO - Running setup.py install for mozprofile 15:15:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:15:11 INFO - Running setup.py install for mozrunner 15:15:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:15:12 INFO - Running setup.py install for mozscreenshot 15:15:12 INFO - Running setup.py install for moztest 15:15:12 INFO - Running setup.py install for mozversion 15:15:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:15:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:15:12 INFO - Cleaning up... 15:15:12 INFO - Return code: 0 15:15:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:12 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:12 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 15:15:12 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 15:15:12 INFO - Using env: {'DISPLAY': ':0', 15:15:12 INFO - 'HOME': '/home/cltbld', 15:15:12 INFO - 'LANG': 'en_US.UTF-8', 15:15:12 INFO - 'LANGUAGE': 'en_US:en', 15:15:12 INFO - 'LOGNAME': 'cltbld', 15:15:12 INFO - 'MAIL': '/var/mail/cltbld', 15:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:12 INFO - 'MOZ_NO_REMOTE': '1', 15:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:12 INFO - 'NO_EM_RESTART': '1', 15:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:12 INFO - 'PWD': '/builds/slave/test', 15:15:12 INFO - 'SHELL': '/bin/bash', 15:15:12 INFO - 'SHLVL': '1', 15:15:12 INFO - 'TERM': 'linux', 15:15:12 INFO - 'TMOUT': '86400', 15:15:12 INFO - 'USER': 'cltbld', 15:15:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:12 INFO - '_': '/tools/buildbot/bin/python'} 15:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:15:12 INFO - Running setup.py (path:/tmp/pip-Sj1kvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:15:12 INFO - Running setup.py (path:/tmp/pip-1RM3gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:15:12 INFO - Running setup.py (path:/tmp/pip-4snIwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:15:12 INFO - Running setup.py (path:/tmp/pip-KCHxi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:15:12 INFO - Running setup.py (path:/tmp/pip-9YgKtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:15:12 INFO - Running setup.py (path:/tmp/pip-fqnL5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:15:12 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)) 15:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:15:12 INFO - Running setup.py (path:/tmp/pip-Glb6lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:15:13 INFO - Running setup.py (path:/tmp/pip-M5NZwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:15:13 INFO - Running setup.py (path:/tmp/pip-jcNMpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:15:13 INFO - Running setup.py (path:/tmp/pip-AjBccD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:15:13 INFO - Running setup.py (path:/tmp/pip-PHkSSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:15:13 INFO - Running setup.py (path:/tmp/pip-ZUK_P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:15:13 INFO - Running setup.py (path:/tmp/pip-vAjqDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:15:13 INFO - Running setup.py (path:/tmp/pip-KlqJhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:13 INFO - Running setup.py (path:/tmp/pip-dGkaop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:15:13 INFO - Running setup.py (path:/tmp/pip-E8yfBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:15:13 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)) 15:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:15:13 INFO - Running setup.py (path:/tmp/pip-7Xrr4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:15:13 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)) 15:15:13 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)) 15:15:13 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)) 15:15:13 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)) 15:15:13 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)) 15:15:13 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)) 15:15:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:15:13 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 15:15:13 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 15:15:13 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 15:15:13 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 15:15:13 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 15:15:13 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 15:15:15 INFO - Downloading blessings-1.6.tar.gz 15:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:15:15 INFO - Installing collected packages: blessings 15:15:15 INFO - Running setup.py install for blessings 15:15:15 INFO - Successfully installed blessings 15:15:15 INFO - Cleaning up... 15:15:15 INFO - Return code: 0 15:15:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:16 INFO - Reading from file tmpfile_stdout 15:15:16 INFO - Current package versions: 15:15:16 INFO - argparse == 1.2.1 15:15:16 INFO - blessings == 1.6 15:15:16 INFO - blobuploader == 1.2.4 15:15:16 INFO - docopt == 0.6.1 15:15:16 INFO - functools32 == 3.2.3-2 15:15:16 INFO - jsonschema == 2.5.1 15:15:16 INFO - manifestparser == 1.1 15:15:16 INFO - mozInstall == 1.12 15:15:16 INFO - mozcrash == 0.17 15:15:16 INFO - mozdebug == 0.1 15:15:16 INFO - mozdevice == 0.48 15:15:16 INFO - mozfile == 1.2 15:15:16 INFO - mozhttpd == 0.7 15:15:16 INFO - mozinfo == 0.9 15:15:16 INFO - mozleak == 0.1 15:15:16 INFO - mozlog == 3.4 15:15:16 INFO - moznetwork == 0.27 15:15:16 INFO - mozprocess == 0.23 15:15:16 INFO - mozprofile == 0.28 15:15:16 INFO - mozrunner == 6.12 15:15:16 INFO - mozscreenshot == 0.1 15:15:16 INFO - mozsystemmonitor == 0.3 15:15:16 INFO - moztest == 0.7 15:15:16 INFO - mozversion == 1.4 15:15:16 INFO - psutil == 3.1.1 15:15:16 INFO - requests == 1.2.3 15:15:16 INFO - wsgiref == 0.1.2 15:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:15:16 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')]} 15:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:16 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')]} 15:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:16 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:16 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 15:15:16 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 15:15:16 INFO - Using env: {'DISPLAY': ':0', 15:15:16 INFO - 'HOME': '/home/cltbld', 15:15:16 INFO - 'LANG': 'en_US.UTF-8', 15:15:16 INFO - 'LANGUAGE': 'en_US:en', 15:15:16 INFO - 'LOGNAME': 'cltbld', 15:15:16 INFO - 'MAIL': '/var/mail/cltbld', 15:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:16 INFO - 'MOZ_NO_REMOTE': '1', 15:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:16 INFO - 'NO_EM_RESTART': '1', 15:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:16 INFO - 'PWD': '/builds/slave/test', 15:15:16 INFO - 'SHELL': '/bin/bash', 15:15:16 INFO - 'SHLVL': '1', 15:15:16 INFO - 'TERM': 'linux', 15:15:16 INFO - 'TMOUT': '86400', 15:15:16 INFO - 'USER': 'cltbld', 15:15:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:16 INFO - '_': '/tools/buildbot/bin/python'} 15:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 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)) 15:15:16 INFO - Cleaning up... 15:15:16 INFO - Return code: 0 15:15:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:15:16 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')]} 15:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:16 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')]} 15:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:16 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 0x7f5c7b35ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e1790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, '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': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', '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 15:15:16 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 15:15:16 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 15:15:16 INFO - Using env: {'DISPLAY': ':0', 15:15:16 INFO - 'HOME': '/home/cltbld', 15:15:16 INFO - 'LANG': 'en_US.UTF-8', 15:15:16 INFO - 'LANGUAGE': 'en_US:en', 15:15:16 INFO - 'LOGNAME': 'cltbld', 15:15:16 INFO - 'MAIL': '/var/mail/cltbld', 15:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:16 INFO - 'MOZ_NO_REMOTE': '1', 15:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:16 INFO - 'NO_EM_RESTART': '1', 15:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:16 INFO - 'PWD': '/builds/slave/test', 15:15:16 INFO - 'SHELL': '/bin/bash', 15:15:16 INFO - 'SHLVL': '1', 15:15:16 INFO - 'TERM': 'linux', 15:15:16 INFO - 'TMOUT': '86400', 15:15:16 INFO - 'USER': 'cltbld', 15:15:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:16 INFO - '_': '/tools/buildbot/bin/python'} 15:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:15:16 INFO - Cleaning up... 15:15:16 INFO - Return code: 0 15:15:16 INFO - Running post-action listener: _resource_record_post_action 15:15:16 INFO - Running post-action listener: _start_resource_monitoring 15:15:16 INFO - Starting resource monitoring. 15:15:16 INFO - [mozharness: 2016-10-04 22:15:16.658909Z] Finished create-virtualenv step (success) 15:15:16 INFO - [mozharness: 2016-10-04 22:15:16.659428Z] Running install step. 15:15:16 INFO - Running pre-action listener: _resource_record_pre_action 15:15:16 INFO - Running main action method: install 15:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:15:16 INFO - Reading from file tmpfile_stdout 15:15:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:15:16 INFO - Reading from file tmpfile_stdout 15:15:16 INFO - Output received: 15:15:16 INFO - Usage: mozinstall [options] installer 15:15:16 INFO - Options: 15:15:16 INFO - -h, --help show this help message and exit 15:15:16 INFO - -d DEST, --destination=DEST 15:15:16 INFO - Directory to install application into. [default: 15:15:16 INFO - "/builds/slave/test"] 15:15:16 INFO - --app=APP Application being installed. [default: firefox] 15:15:16 INFO - mkdir: /builds/slave/test/build/application 15:15:16 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'] 15:15:16 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 15:15:33 INFO - Reading from file tmpfile_stdout 15:15:33 INFO - Output received: 15:15:33 INFO - /builds/slave/test/build/application/firefox/firefox 15:15:33 INFO - Running post-action listener: _resource_record_post_action 15:15:33 INFO - [mozharness: 2016-10-04 22:15:33.972123Z] Finished install step (success) 15:15:33 INFO - [mozharness: 2016-10-04 22:15:33.972456Z] Running run-tests step. 15:15:33 INFO - Running pre-action listener: _resource_record_pre_action 15:15:33 INFO - Running main action method: run_tests 15:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:15:33 INFO - Python 2.7.3 15:15:33 INFO - Return code: 0 15:15:33 INFO - grabbing minidump binary from tooltool 15:15: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')]} 15:15:33 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 0x22de930>, '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 0x22df830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22dfcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:15:33 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 15:15:33 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 15:15:33 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 15:15:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:34 INFO - Return code: 0 15:15:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:15:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:15:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:15:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:15:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 15:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 15:15:34 INFO - Using env: {'DISPLAY': ':0', 15:15:34 INFO - 'HOME': '/home/cltbld', 15:15:34 INFO - 'LANG': 'en_US.UTF-8', 15:15:34 INFO - 'LANGUAGE': 'en_US:en', 15:15:34 INFO - 'LOGNAME': 'cltbld', 15:15:34 INFO - 'MAIL': '/var/mail/cltbld', 15:15:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:15:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:34 INFO - 'MOZ_NO_REMOTE': '1', 15:15:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:34 INFO - 'NO_EM_RESTART': '1', 15:15:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:34 INFO - 'PWD': '/builds/slave/test', 15:15:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:15:34 INFO - 'SHELL': '/bin/bash', 15:15:34 INFO - 'SHLVL': '1', 15:15:34 INFO - 'TERM': 'linux', 15:15:34 INFO - 'TMOUT': '86400', 15:15:34 INFO - 'USER': 'cltbld', 15:15:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311', 15:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:34 INFO - '_': '/tools/buildbot/bin/python'} 15:15:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 15:15:34 INFO - mozversion application_buildid: 20161004123000 15:15:34 INFO - mozversion application_changeset: ad324639bfaeba6d7be3b732295b6a27d0c54e0a 15:15:34 INFO - mozversion application_display_name: Nightly 15:15:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:34 INFO - mozversion application_name: Firefox 15:15:34 INFO - mozversion application_remotingname: firefox 15:15:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:15:34 INFO - mozversion application_vendor: Mozilla 15:15:34 INFO - mozversion application_version: 52.0a1 15:15:34 INFO - mozversion platform_buildid: 20161004123000 15:15:34 INFO - mozversion platform_changeset: ad324639bfaeba6d7be3b732295b6a27d0c54e0a 15:15:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:15:34 INFO - mozversion platform_version: 52.0a1 15:15:34 INFO - using testdate: 1475619334 15:15:34 INFO - actual date: 1475619334 15:15:34 INFO - starting webserver on 'localhost:38042' 15:15:34 INFO - SUITE-START | Running 2 tests 15:15:34 INFO - TEST-START | dromaeo_css 15:15:34 INFO - operating with platform_type : linux_ 15:15:34 INFO - Initialising browser for dromaeo_css test... 15:15:34 INFO - TEST-INFO | started process 12888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWsUAs2/profile http://localhost:38042/getInfo.html) 15:15:38 INFO - PROCESS | 12888 | __metrics Screen width/height:1600/1200 15:15:38 INFO - PROCESS | 12888 | colorDepth:24 15:15:38 INFO - PROCESS | 12888 | Browser inner width/height: 1024/697 15:15:38 INFO - PROCESS | 12888 | __metrics 15:15:39 INFO - PROCESS | 12888 | 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" 15:15:39 INFO - PROCESS | 12888 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:15:39 INFO - PROCESS | 12888 | console.error: PushService: 15:15:39 INFO - PROCESS | 12888 | stateChangeProcessEnqueue: Error transitioning state 15:15:39 INFO - PROCESS | 12888 | UnknownError 15:15:40 INFO - TEST-INFO | 12888: exit 0 15:15:40 INFO - Browser initialized. 15:15:40 INFO - Running cycle 1/1 for dromaeo_css test... 15:15:40 INFO - TEST-INFO | started process 12969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWsUAs2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:52 INFO - PROCESS | 12969 | RSS: Main: 177983488 15:15:52 INFO - PROCESS | 12969 | 15:16:43 INFO - PROCESS | 12969 | 1475619403557 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] 15:18:54 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:38042/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38042/tests/dromaeo/cssquery-ext.html) 15:18:55 INFO - PROCESS | 12969 | RSS: Main: 271081472 15:18:55 INFO - PROCESS | 12969 | 15:21:58 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:38042/tests/dromaeo/cssquery-ext.html (next: http://localhost:38042/tests/dromaeo/cssquery-jquery.html) 15:21:58 INFO - PROCESS | 12969 | RSS: Main: 273481728 15:21:58 INFO - PROCESS | 12969 | 15:25:00 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:38042/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38042/tests/dromaeo/cssquery-mootools.html) 15:25:01 INFO - PROCESS | 12969 | RSS: Main: 255303680 15:25:01 INFO - PROCESS | 12969 | 15:28:03 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:38042/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38042/tests/dromaeo/cssquery-prototype.html) 15:28:03 INFO - PROCESS | 12969 | RSS: Main: 237735936 15:28:03 INFO - PROCESS | 12969 | 15:31:06 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:38042/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38042/tests/dromaeo/cssquery-yui.html) 15:31:07 INFO - PROCESS | 12969 | RSS: Main: 217100288 15:31:07 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | Cycle 1(1): loaded http://localhost:38042/tests/dromaeo/cssquery-yui.html (next: http://localhost:38042/tests/dromaeo/cssquery-dojo.html) 15:34:10 INFO - PROCESS | 12969 | RSS: Main: 305852416 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | __start_tp_report 15:34:10 INFO - PROCESS | 12969 | _x_x_mozilla_page_load 15:34:10 INFO - PROCESS | 12969 | _x_x_mozilla_page_load_details 15:34:10 INFO - PROCESS | 12969 | |i|pagename|runs| 15:34:10 INFO - PROCESS | 12969 | |0;dojo.html;2973.212098793819;3020.4261190373813;3023.576699262103;3050.374673191996;3071.9385612287756;5075.9492405075935;5134.050200712871;5233.502817232362;5297.682139071659;5313.548348390386;5095.8216462423825;5174.715390653512;5228.895422091556;5285.127953887613;5338.67967921925;4665.2768820832825;4724.881877953061;4730.97634511827;4744.240921452569;4785.569298763111;4733.763311834412;4783.856484305459;4800.927986080212;4816.229403295473;4835.492273311304;4589.816407343702;4622.815087396534;4864.051509955542;4908.926366104493;4909.21452567591;4670.673052886299;4676.602488788457;4677.298405239208;4679.766011699401;4681.368015317923;4650.627949764011;4654.208784506642;4659.953400465985;4660.697054691468;4671.95328046722;5017.347744793154;5070.873228169288;5075.492450754932;5080.695158290514;5081.161608334621;5395.919061214085;5495.477929596682;5507.752151153168;5586.804461843856;5591.832245032615;5495.395506494282;5510.6418082824885;5512.090505066659;5575.275214222166;5575.526080283181;5216.63483556155;5217.791288348461;5230.503102205284;5230.947690523122;5244.213367994793;5377.704226267593;5411.107167317427;5638.830835074954;5669.348024977098;5736.713164341766;5521.089020311603;5524.14375771756;5534.252875861787;5534.86162845924;5545.334559852763;5608.551315894719;5612.130119831432;5612.382637909826;5617.354004289477;5621.606487545914;5294.338207724035;5345.893082138336;5440.265564148789;5447.618666693373;5525.4474552544425;5553.583481238923;5553.722313884289;5556.972215138899;5560.610757247035;5614.63504872182;4318.913621727611;4320.027993701392;4320.870373888788;4360.716553424018;4371.912561748747;3725.2735716535017;3743.7753734775456;3767.3407153747985;3776.546814382292;3850.1914597934187;5165.690058596496;5165.974170129125;5167.586593072545;5170.71561064145;5212.582993360522;5442.91835622466;5474.343078830486;5487.847552014042;5499.037668408013;5546.972265138648;5062.265971434195;5064.518870707277;5182.4299327073995;5247;5286.20706893969;4896.975515122402;4901.117798796179;4901.191303434894;4906;4956.4547899731;5745.85635359111;5766.135079737989;5774.0761478163295;5841.970790146107;5843.94156058434;5323.414424413389;5391.379991300893;5437.782488700566;5656.971715141398;5663.716814159358;5676.574256930664;5701.828945131652;5704.572157088152;5752.511036561939;5770.13447982806;5444.1017232156255;5444.1017232156255;5445.1832225166545;5445.863853403696;5450.182472629137;5321.255024296524;5339.4660533947845;5502.862428439321;5527.364353099445;5587.916181257203;5331.280277162688;5345.65253258537;5399.217113518596;5417.214503896992;5444.428335024765;5407.86480337979;5411.594130440311;5417.945820541744;5423.538999185113;5423.5932305076485;5212.4005739338945;5389.299391079291;5402.486763757437;5404.891902162013;5465.672059676433;5309.256704061358;5337.759800808895;5408.972955135199;5412.56699464034;5494.505494505353;5303.124984377535;5320.52115309624;5322.946770532245;5329.9467005331;5330.78676852937 15:34:10 INFO - PROCESS | 12969 | |1;ext.html;561.76405909518;594.598645914008;604.190384884255;618.4773866083161;628.1614045249592;31196.22009449762;32215.67784322159;34327.82836085816;34392.656073439226;41251.58748412515;43591.025435930256;43827.342589861175;43914.78042609782;43938.7803060985;43981.56018439815;8903.777405564848;9055.683051093212;9055.683051093212;9063.274938004944;9063.45619262843;8762.386632935697;8870.556472176399;8875.245604123656;8875.68935087272;8876.556172191396;8890.644374225056;8941.821163576724;8943.731688049369;8945.731628051137;8947.194752472276;8843.425177363451;8883.600237989305;8889.955550222208;8892.644294228223;8898;8577.614007369682;8709.303255739525;8717.4333668312;8721.30229581632;8729.127087291283;40770;40898.79550602258;41074.794626026975;41125.58874411247;41354.1729165418;3096.427160975227;3171.175494371457;3235.6440791512914;3263.0863358259726;3599.2441587266703;28408.28979275514;28842.855785721145;28863.278418039507;28883.711162888314;29064.273393165127;3923.195744872294;3983.7609743415487;4082.7346222495444;4116.629503344683;4163.687723420756;317842;317943;318549;318651;318709;45591.54408455939;46976;52477;52627.73686131621;52846.47153528415;47297.527024729316;47746.28380574294;48112.5188748115;48338;48394.274085888035;16626.916865415595;16768.664626707643;16792.748108778378;16794;16798.160091995353;13146.802797958038;13244.470221191044;13255.204687718575;13255.403506842214;13262.679031169506;13269.213465172228;13687.520936767165;14672;15209;15236.847631523542;5571.331440227118;5869.354371019184;5887.470127688529;5943.732532036069;5971;846.2005594879072;856.5759948825371;949.9857502137473;1039.0077476010392;1040.7190058684114;28472.145835624964;29207.85396073006;29446.705532944397;29896.701032989393;29955;991.3011327014437;1030.3766221436074;1053.099599842124;1105.2484310668663;1131.4795194210756;15063.774043389358;15553.911226214283;15715.607109822116;15739.370425182864;16045.839541604435;461094;465615;467066;467286;467305;54329.185062224096;54500;54538;54553.45446545484;54566;1321.5572783117764;1324.6555895467247;1354.0251019266113;1354.4988354308969;1356.9253691047088;27675.308117297227;28468.85765571159;29055.128346148802;29311.560326595543;29410.411791764473;46701.76649116733;46921;46973.295400568335;47034.29448558343;47042.29436558386;426194;427645;428902;429292;430240;23105.537889241783;24020.87989560041;26188.607170892832;26349.34126646849;26762.330941726614;42445;43156.78421607872;44002.55997440113;44469.77765111154;45057;36546.451803222444;37066.8146659265;38108.42837357497;38615.6138438612;39296;36885;37223.25553488969;37687;37931.81034094812;39284.80357598194;37221.627783721815;38684.61315386923;40322.79838600788;41032.384514231715;41157.382639261035;39386;39733.80133099432;40140.7992960045;41222.58777412187;41321;30579.2355191122;31952.36095278128;32119.678803211667;32502.349953000336;32703.509447357832 15:34:10 INFO - PROCESS | 12969 | |2;jquery.html;391.9216156768647;396.18781497929257;403.2680684557529;407.3218091877025;421.4647397804788;14099.647508812259;17097.91451042746;17522.824771752294;19238.422847314585;19268.518287042814;17833.46499605014;18813.247470101214;19564.41306760796;19709.40871773849;19889.104990275435;5348.5453736432255;5393.7033463159605;5506.697131657757;5532.170174473841;5540.63985840919;4079.755214687128;5524.530414914717;5554.222408862763;5600.691961942091;5606.747696353674;4409.757463339515;6145.139680444719;6230.875382492348;6232.844178895519;6241.1574437451045;6170.475509581668;6245.219347581552;6252.218472690914;6254.280757712831;6287.96856015717;5413.648112872651;5524.392316845144;5544.112941929312;5545.1682247663175;5553.861153471195;22134;22942.31173064794;22986.42533936665;23080.538389232122;23206.3038108857;2212.2920665387082;2284.805791507724;2432.2946345559767;2672.0113557983477;2883.6539615246306;13246.337683115806;14057.367418466194;14178.922362058036;14301.499447519287;14575.416983320654;1806.4400035988886;1813.9909300453414;1816.2644129127725;1845.151230434002;1862.7705714228543;80362;80405;81335;82237;82859;9974.900250997542;10152.847707284396;10373.302941235333;10430.37417754937;10452.843207351896;12761.68095797594;14980.625484362978;14981.625459363604;14981.775273370908;14993.775093373608;7515.473916825879;7595;7893.802654933673;8012.559309238048;8056.113827478973;7700.961495192488;7723.729669461542;7949.880751788728;7963.960180199178;8032.518048917083;6269.216347956505;6410.294867564564;6458.418742313214;6509.218893732783;6549.9345006550275;1862.32956135791;1878.3238034307637;1898.2691663709572;1937.2832052140516;1964.3910387779833;838.6603425612636;979.1432496565506;980.2550061952825;983.2036050798876;1033.617561502234;17536.932058971706;18880.622387552172;19223.61552768937;19455;19475.51311217231;953.609020301673;965.9034096590285;969.2021300487494;979.7942432089199;985.9161971232526;9794.95102524497;10711;10915.126789856793;10986;11000.504977276041;355852;358632;360523;452667;473827;88669;91415.00237458418;92010.53994729984;92663.5366823175;93037.53481232686;992.8957459466652;1010.1312870930993;1012.7771890184148;1027.465717826741;1037.7094413564214;16169.514914552583;16383.754243686115;16581.91709041447;16869.746953795457;17026.65946681084;29830.55254171146;40622.18755624812;40768.79615602022;42180.15639687128;42347.364789527564;42967.57032429761;52405.21392179044;52507.47492525026;53382.73308633432;56891.354877409045;7790.454668173174;7944.324732397811;8108.729555724407;8201.71294004707;8512.489250644981;11988.700282492659;12148.817767733668;12279.140460167702;12657;12855.485780568673;11192.921946464787;11266.83099753488;11362.14783891228;11752.23610465317;11878.346690931736;6554.606723596599;11088.501017454073;11185.608503702331;11231.71920701989;11426.82859757121;11308.151888608223;11372.54509819598;11627.883721163018;11732.530698771954;12005.63983080509;8008.11910689812;8110.756677299691;8133.471324363897;8285;8381.203785640355;8639.740807775777;10793.136549075898;10960.451977401257;11122.721931951766;11520.769584608428 15:34:10 INFO - PROCESS | 12969 | |3;mootools.html;1447.0666420158998;1480.4300344367418;1604.7432410814265;1718.5617667494787;1738.2091148527413;8132.227438393358;8436.282915952152;8736.8689469658;9399.436033837967;9473.289503287264;8790.384673072887;9191.310651701133;9239.722808315744;9505.477198754066;9512.23902087833;2296.311106667997;2341;2341.086976079322;2348.6124789409814;2351.6825228594175;1928.4793105861409;1998.6802111662064;2290.7938285554296;2359.339384972202;2371.2530552875874;2178.0852042142337;2266;2267.637178051512;2278.9544209115807;2284.4060544258527;2317.2237300504185;2322.291701031185;2324.5583339165505;2331.813454923602;2335.486193037529;2303.4356582637192;2320.9767902320928;2339.099446713011;2340.9297721068397;2343.437574982009;9193.540322983825;9345.485998270093;9350.064993500664;9371.625134994592;9376.765580860465;5086.720230387327;5213.895722085537;5236.162214045772;5240.423553409122;5243.895122097537;3176.4600017996995;3191.5850939377965;3326.284848757529;3340.682635149657;3360.24394511233;1022.8210063238903;1051.8737751469796;1060.1677683018793;1062.0919114157361;1069.3263244156133;13151.671208219776;13175.34123293841;13260.071794974356;13263.403146858318;13290.335483225897;4262.296721041055;4266;4425.5574442556135;4432.069265454226;4566.657500687462;10915.617953371593;10941.4529273536;10950.39772812487;10955.287906286067;10962.287451315799;5218.765155568009;5223.059849227176;5231.24146998683;5232.136697444879;5233.241180028875;4737.336772851803;4802.159622066124;4811.08589368019;4822.035592881438;4826.565609095128;3819.255245227154;3843.865464708778;3883.203943191639;3923.372260438316;3956.7823769692945;1102.2669924500117;1132.9320240785414;1151.090638395658;1189.6966273600176;1207.4264724256084;721.6427868205272;827.8054657155564;848.253536887535;852.7100785732881;872.5549969515592;5542.140968149944;5568.693721845338;5630.3402788188005;5672.914906276409;5722;865.5931712095305;881.0572687224608;929.9163075323254;930.2000279759537;949.8100379923904;3707.796071216109;3740.2893450244364;3743.6630703236838;3749.49381833449;3772.86794962175;11356.94321528387;11854.822177667342;11863.347515886537;11897.524099035942;11907.345096019802;11760.176787624785;11829.231099978473;11836;11870.169088163746;11873.940630296966;8034.076081250614;8099.433039687166;8189.79525511867;8196.83606327882;8197.221263979913;5443.945560544502;5502.697351645698;5521.171824226398;5637.689927054052;5640.633358831663;10530.420826854597;10546.947265263625;10556.366618002945;10684;10716.35701857891;10488.528016239135;10590.417527036087;10610.734731631463;10838.891611083789;10944.671659850217;7783.1827658097345;7922.762317130495;7928.682852685828;7935.2064793520185;7942.761717148494;8332.125126861834;8665.566721663765;8732;8847.601857916537;8927.24118449939;6756.966215168893;7676.424268179797;7741.419393545394;8032.437729358889;8082.919170808452;7550.66022028999;7739.071311442663;7746.225377462434;7753.457257991887;7795.298423141944;6387.776427825004;6583.210014798255;6586.341365863375;6892.138482689664;6907.171139463297;5070.442251352422;5180.507851754077;5198.298229738937;5217.556507696889;5227.954409118115;4906;4986.002799440054;5127.820526281562;5156.278121063129;5184.766685499237 15:34:10 INFO - PROCESS | 12969 | |4;prototype.html;328.35478285169637;332.854978872678;339.8504657950502;341.8735068024831;345.7441493294962;5019.774110165043;5149.588032957364;5172.948270517294;5210.478952104792;5250.1074817281105;4936.975315123419;5086.186210206368;5106.5148810863;5108.310378098956;5114.590832733382;4051.2910240707906;4066.1054567994993;4081.469408976829;4087.305158123111;4090.754554726711;3914.0022050716643;4079.898002549945;4085.9182816343655;4090.7750073745933;4112.897177570555;4061.289274376987;4074.5110586729484;4089.652379547727;4094.651954583849;4096.97951510242;4045.575214602454;4053.7770422626745;4056.452378928851;4066;4077.408775727503;3670.687991520724;3674.1733110050027;3679.521662183926;3686.594474607791;3697.9445308320396;4793;4980.705016695649;5007.974960125212;5047.848564543069;5081.644284900059;4586.518415566385;4596.724196548218;4614.792334344963;4621.867642427593;4632.536746325341;5332.813351532716;5345.465453454663;5349;5349.893002139975;5355.0896347621;3704.0738815815894;3871.825767840454;3910.4720862683744;3927.1163988102735;3928.116173860887;5552.91670624941;5554.833354999357;5595.328560572717;5609.747561359708;5619.409961953977;4026.2953983053435;4050.311447054008;4060.837566497307;4065.2682517146604;4067.254603142867;3997.560268370477;4079.204555111784;4104.261232978092;4114.732542384735;4117.279476091672;4610.631149508032;4612.76936153191;4613.30800379939;4630.21286381316;4641.74470404131;5418.106012507971;5438.483344082306;5442.482964118402;5461.5357694596405;5479.5342395896;1313.5993521975697;1328.8206092177625;1381.1505923856755;1381.171297221679;1403.4947418929178;884.8186121845006;893.6068130022769;900.8423525882944;905.090259552344;917.9265658747285;4475.225360276584;4516.3902873112365;4523.0324808707655;4526.977365113154;4576.908461830745;4768.758683418788;4773.451053128865;4781.617470602413;4808.543188397167;4819.831305904277;4507.504174540798;4525.208088584484;4541.866112382446;4569.794359253841;4575.359449677047;2432.9878350608133;2585.948281034369;2595.6762051353944;2599.935001624937;2600.8049396295355;5012.248162775612;5015.974920125376;5019.498050195024;5045.678987665715;5051.444341122474;4941.950580494149;4949.331840201598;4953.653244272867;4954.925676114861;5005.224190250517;5374;5745.88508229833;5764.394738552475;5765.88468230633;5769.884602307847;5571.526420254324;5573.665580065209;5574.9163762542785;5580.990843296491;5581.944180558143;5230.34620672416;5487.670739755467;5496.477834605706;5517.310336207974;5554.805581804618;5737.8565535861935;5739.454751798572;5742.511886489695;5750.741216645178;5778.104393818965;3927.8821635350987;3942.6845852332317;3950.7234493585174;3952.446657467899;3963.4649322341115;5301;5373.704446255337;5527.944720552743;5532.6680399176175;5543.750531226024;5235.65968212065;5280.973595132;5364.275822763877;5366.973165134305;5381.165919282517;5370.113931201308;5373.570114390761;5374.919376209282;5468.0977638690765;5476.80831170923;5226.346706661668;5332.78668853257;5366.838994830161;5386.5152136307925;5387.218853266176;5409.377921539073;5412.78348866041;5419.132938729785;5423.891522169613;5441.700706461183;5280.075986702235;5304.628675992643;5307.761150748149;5319.175527793198;5335.413104558418 15:34:10 INFO - PROCESS | 12969 | |5;yui.html;651.9119918810962;653.8365408647837;666.2604508995017;738.9815254618634;740.4298690008693;14685.853141468595;16360.018398896074;16557.337706491726;16614.91692541537;16617.83382166178;14947.028443151188;15062.698746025073;15245.31396087176;15256.160911149882;15256.466023689172;788.6293442082213;802.3100133884855;811.2252798577344;811.8457493076326;812.0052935154448;658.5521845145323;677.6713294052381;782.0693374883898;809.7692157735047;813.7477382011566;840.357126798;846.2468403121227;846.3948276981956;846.4963346808639;846.5090247656375;835.3734698975768;835.6907944060737;836.8410002099581;837.0457678246803;843.1273631791097;497.93028975943395;505.08327385794666;510.58132331487826;615.1449485215554;615.2063837649426;11210.775784484345;13618.250996195206;14125.576232713034;14144.929275353661;14633.853661463356;13839;14687.853121468755;14801;14881.925590372088;15230.695386092217;10516.211284153642;10561.841572376421;10658.946705266502;10719.196060295431;10899.83650245247;3520.577530696333;3524.1894364296354;3576.213233088716;3593.3711600469815;3599.5140656011627;72843.27156728417;74336.62831685807;77335.22664773336;77433.61283193604;78442;10328.690139295833;10335.74160645975;10443.477826108665;10516;10942.45887956505;22062.558748825253;22262.777372226396;22264.554708905733;22330.330090097323;22355.441113971956;7569.772906812805;7728;7896.565688887166;7915.525068495794;8342.66629334832;4077.55146933837;4136.358864376027;4144.089556834716;4158.189153115174;4272.124214536075;3513.894583162509;3630.364686179908;3841.7118716096406;4025.75845449274;4032.2540330039037;682.6245564939263;692.2247083266774;695.2421860172436;700.7477308169055;703.4513079797766;615.2893408113636;699.5418001209216;705.4074577355046;718.9352958233784;739.5193124469031;9007.549622518847;9013.18881300686;9195.63217471307;9258.583363748512;9330.440173589606;567.5289509706934;601.2721129000216;651.5894986158689;657.7599176300616;673.4574452257945;4403.471583410012;4486.439195100613;4522.276435770261;4571.51999040096;4627.629789616823;65987.67006164939;105160.47419763006;118150;125767;131275;109994;110768;110939.89060109456;111119;112885.4355728216;72953.6352318235;86485.70271445933;86831.13168868357;87679;89227.55386223027;9312.534373281173;9646.758831029281;9673.903260967581;9723.367981081206;9738.707838764849;49493.50506494889;49992.50007499878;50658.74670626623;51438;51543.226851598;68018.65990670015;69465;73800;74738;77505;11932.16474846787;12027.338496382783;12187.390630468619;12444.937775311428;12706;12843.550475733304;12901.935490322863;13248.602541923758;13293.401796919356;13914.652133696738;12549;12566.685832854251;13163.67090822737;13477.39351729155;13592.388342524413;11500;11805.409729513662;11808.70478238051;12066.336351500751;12457.819881520878;11097.223194376316;11266.324020558794;11416.771664566497;11452.885471145182;11615.128865334964;9387.202087822612;9558.904410955802;9769.658061967797;9964.850527241952;10135.645252416425;10068.24488163376;10324.690259292232;10401.375917444675;10522.894771052192;10569.524371403151 15:34:10 INFO - PROCESS | 12969 | __end_tp_report 15:34:10 INFO - PROCESS | 12969 | __start_cc_report 15:34:10 INFO - PROCESS | 12969 | _x_x_mozilla_cycle_collect,1285 15:34:10 INFO - PROCESS | 12969 | __end_cc_report 15:34:10 INFO - PROCESS | 12969 | __startTimestamp1475620450417__endTimestamp 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | ------- Summary: start ------- 15:34:10 INFO - PROCESS | 12969 | Number of tests: 6 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | [#0] dojo.html Cycles:165 Average:5145.50 Median:5329.95 stddev:570.10 (10.7%) stddev-sans-first:545.79 15:34:10 INFO - PROCESS | 12969 | Values: 2973.2 3020.4 3023.6 3050.4 3071.9 5075.9 5134.1 5233.5 5297.7 5313.5 5095.8 5174.7 5228.9 5285.1 5338.7 4665.3 4724.9 4731.0 4744.2 4785.6 4733.8 4783.9 4800.9 4816.2 4835.5 4589.8 4622.8 4864.1 4908.9 4909.2 4670.7 4676.6 4677.3 4679.8 4681.4 4650.6 4654.2 4660.0 4660.7 4672.0 5017.3 5070.9 5075.5 5080.7 5081.2 5395.9 5495.5 5507.8 5586.8 5591.8 5495.4 5510.6 5512.1 5575.3 5575.5 5216.6 5217.8 5230.5 5230.9 5244.2 5377.7 5411.1 5638.8 5669.3 5736.7 5521.1 5524.1 5534.3 5534.9 5545.3 5608.6 5612.1 5612.4 5617.4 5621.6 5294.3 5345.9 5440.3 5447.6 5525.4 5553.6 5553.7 5557.0 5560.6 5614.6 4318.9 4320.0 4320.9 4360.7 4371.9 3725.3 3743.8 3767.3 3776.5 3850.2 5165.7 5166.0 5167.6 5170.7 5212.6 5442.9 5474.3 5487.8 5499.0 5547.0 5062.3 5064.5 5182.4 5247.0 5286.2 4897.0 4901.1 4901.2 4906.0 4956.5 5745.9 5766.1 5774.1 5842.0 5843.9 5323.4 5391.4 5437.8 5657.0 5663.7 5676.6 5701.8 5704.6 5752.5 5770.1 5444.1 5444.1 5445.2 5445.9 5450.2 5321.3 5339.5 5502.9 5527.4 5587.9 5331.3 5345.7 5399.2 5417.2 5444.4 5407.9 5411.6 5417.9 5423.5 5423.6 5212.4 5389.3 5402.5 5404.9 5465.7 5309.3 5337.8 5409.0 5412.6 5494.5 5303.1 5320.5 5322.9 5329.9 5330.8 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | [#1] ext.html Cycles:180 Average:55470.66 Median:40965.59 stddev:108232.55 (264.2%) stddev-sans-first:108457.65 15:34:10 INFO - PROCESS | 12969 | Values: 561.8 594.6 604.2 618.5 628.2 31196.2 32215.7 34327.8 34392.7 41251.6 43591.0 43827.3 43914.8 43938.8 43981.6 8903.8 9055.7 9055.7 9063.3 9063.5 8762.4 8870.6 8875.2 8875.7 8876.6 8890.6 8941.8 8943.7 8945.7 8947.2 8843.4 8883.6 8890.0 8892.6 8898.0 8577.6 8709.3 8717.4 8721.3 8729.1 40770.0 40898.8 41074.8 41125.6 41354.2 3096.4 3171.2 3235.6 3263.1 3599.2 28408.3 28842.9 28863.3 28883.7 29064.3 3923.2 3983.8 4082.7 4116.6 4163.7 317842.0 317943.0 318549.0 318651.0 318709.0 45591.5 46976.0 52477.0 52627.7 52846.5 47297.5 47746.3 48112.5 48338.0 48394.3 16626.9 16768.7 16792.7 16794.0 16798.2 13146.8 13244.5 13255.2 13255.4 13262.7 13269.2 13687.5 14672.0 15209.0 15236.8 5571.3 5869.4 5887.5 5943.7 5971.0 846.2 856.6 950.0 1039.0 1040.7 28472.1 29207.9 29446.7 29896.7 29955.0 991.3 1030.4 1053.1 1105.2 1131.5 15063.8 15553.9 15715.6 15739.4 16045.8 461094.0 465615.0 467066.0 467286.0 467305.0 54329.2 54500.0 54538.0 54553.5 54566.0 1321.6 1324.7 1354.0 1354.5 1356.9 27675.3 28468.9 29055.1 29311.6 29410.4 46701.8 46921.0 46973.3 47034.3 47042.3 426194.0 427645.0 428902.0 429292.0 430240.0 23105.5 24020.9 26188.6 26349.3 26762.3 42445.0 43156.8 44002.6 44469.8 45057.0 36546.5 37066.8 38108.4 38615.6 39296.0 36885.0 37223.3 37687.0 37931.8 39284.8 37221.6 38684.6 40322.8 41032.4 41157.4 39386.0 39733.8 40140.8 41222.6 41321.0 30579.2 31952.4 32119.7 32502.3 32703.5 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | [#2] jquery.html Cycles:180 Average:26149.93 Median:394.05 stddev:67093.52 (17026.4%) stddev-sans-first:67253.86 15:34:10 INFO - PROCESS | 12969 | Values: 391.9 396.2 403.3 407.3 421.5 14099.6 17097.9 17522.8 19238.4 19268.5 17833.5 18813.2 19564.4 19709.4 19889.1 5348.5 5393.7 5506.7 5532.2 5540.6 4079.8 5524.5 5554.2 5600.7 5606.7 4409.8 6145.1 6230.9 6232.8 6241.2 6170.5 6245.2 6252.2 6254.3 6288.0 5413.6 5524.4 5544.1 5545.2 5553.9 22134.0 22942.3 22986.4 23080.5 23206.3 2212.3 2284.8 2432.3 2672.0 2883.7 13246.3 14057.4 14178.9 14301.5 14575.4 1806.4 1814.0 1816.3 1845.2 1862.8 80362.0 80405.0 81335.0 82237.0 82859.0 9974.9 10152.8 10373.3 10430.4 10452.8 12761.7 14980.6 14981.6 14981.8 14993.8 7515.5 7595.0 7893.8 8012.6 8056.1 7701.0 7723.7 7949.9 7964.0 8032.5 6269.2 6410.3 6458.4 6509.2 6549.9 1862.3 1878.3 1898.3 1937.3 1964.4 838.7 979.1 980.3 983.2 1033.6 17536.9 18880.6 19223.6 19455.0 19475.5 953.6 965.9 969.2 979.8 985.9 9795.0 10711.0 10915.1 10986.0 11000.5 355852.0 358632.0 360523.0 452667.0 473827.0 88669.0 91415.0 92010.5 92663.5 93037.5 992.9 1010.1 1012.8 1027.5 1037.7 16169.5 16383.8 16581.9 16869.7 17026.7 29830.6 40622.2 40768.8 42180.2 42347.4 42967.6 52405.2 52507.5 53382.7 56891.4 7790.5 7944.3 8108.7 8201.7 8512.5 11988.7 12148.8 12279.1 12657.0 12855.5 11192.9 11266.8 11362.1 11752.2 11878.3 6554.6 11088.5 11185.6 11231.7 11426.8 11308.2 11372.5 11627.9 11732.5 12005.6 8008.1 8110.8 8133.5 8285.0 8381.2 8639.7 10793.1 10960.5 11122.7 11520.8 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | [#3] mootools.html Cycles:180 Average:5895.16 Median:4769.75 stddev:3553.99 (74.5%) stddev-sans-first:3548.25 15:34:10 INFO - PROCESS | 12969 | Values: 1447.1 1480.4 1604.7 1718.6 1738.2 8132.2 8436.3 8736.9 9399.4 9473.3 8790.4 9191.3 9239.7 9505.5 9512.2 2296.3 2341.0 2341.1 2348.6 2351.7 1928.5 1998.7 2290.8 2359.3 2371.3 2178.1 2266.0 2267.6 2279.0 2284.4 2317.2 2322.3 2324.6 2331.8 2335.5 2303.4 2321.0 2339.1 2340.9 2343.4 9193.5 9345.5 9350.1 9371.6 9376.8 5086.7 5213.9 5236.2 5240.4 5243.9 3176.5 3191.6 3326.3 3340.7 3360.2 1022.8 1051.9 1060.2 1062.1 1069.3 13151.7 13175.3 13260.1 13263.4 13290.3 4262.3 4266.0 4425.6 4432.1 4566.7 10915.6 10941.5 10950.4 10955.3 10962.3 5218.8 5223.1 5231.2 5232.1 5233.2 4737.3 4802.2 4811.1 4822.0 4826.6 3819.3 3843.9 3883.2 3923.4 3956.8 1102.3 1132.9 1151.1 1189.7 1207.4 721.6 827.8 848.3 852.7 872.6 5542.1 5568.7 5630.3 5672.9 5722.0 865.6 881.1 929.9 930.2 949.8 3707.8 3740.3 3743.7 3749.5 3772.9 11356.9 11854.8 11863.3 11897.5 11907.3 11760.2 11829.2 11836.0 11870.2 11873.9 8034.1 8099.4 8189.8 8196.8 8197.2 5443.9 5502.7 5521.2 5637.7 5640.6 10530.4 10546.9 10556.4 10684.0 10716.4 10488.5 10590.4 10610.7 10838.9 10944.7 7783.2 7922.8 7928.7 7935.2 7942.8 8332.1 8665.6 8732.0 8847.6 8927.2 6757.0 7676.4 7741.4 8032.4 8082.9 7550.7 7739.1 7746.2 7753.5 7795.3 6387.8 6583.2 6586.3 6892.1 6907.2 5070.4 5180.5 5198.3 5217.6 5228.0 4906.0 4986.0 5127.8 5156.3 5184.8 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | [#4] prototype.html Cycles:180 Average:4457.77 Median:4967.82 stddev:1299.83 (26.2%) stddev-sans-first:1265.99 15:34:10 INFO - PROCESS | 12969 | Values: 328.4 332.9 339.9 341.9 345.7 5019.8 5149.6 5172.9 5210.5 5250.1 4937.0 5086.2 5106.5 5108.3 5114.6 4051.3 4066.1 4081.5 4087.3 4090.8 3914.0 4079.9 4085.9 4090.8 4112.9 4061.3 4074.5 4089.7 4094.7 4097.0 4045.6 4053.8 4056.5 4066.0 4077.4 3670.7 3674.2 3679.5 3686.6 3697.9 4793.0 4980.7 5008.0 5047.8 5081.6 4586.5 4596.7 4614.8 4621.9 4632.5 5332.8 5345.5 5349.0 5349.9 5355.1 3704.1 3871.8 3910.5 3927.1 3928.1 5552.9 5554.8 5595.3 5609.7 5619.4 4026.3 4050.3 4060.8 4065.3 4067.3 3997.6 4079.2 4104.3 4114.7 4117.3 4610.6 4612.8 4613.3 4630.2 4641.7 5418.1 5438.5 5442.5 5461.5 5479.5 1313.6 1328.8 1381.2 1381.2 1403.5 884.8 893.6 900.8 905.1 917.9 4475.2 4516.4 4523.0 4527.0 4576.9 4768.8 4773.5 4781.6 4808.5 4819.8 4507.5 4525.2 4541.9 4569.8 4575.4 2433.0 2585.9 2595.7 2599.9 2600.8 5012.2 5016.0 5019.5 5045.7 5051.4 4942.0 4949.3 4953.7 4954.9 5005.2 5374.0 5745.9 5764.4 5765.9 5769.9 5571.5 5573.7 5574.9 5581.0 5581.9 5230.3 5487.7 5496.5 5517.3 5554.8 5737.9 5739.5 5742.5 5750.7 5778.1 3927.9 3942.7 3950.7 3952.4 3963.5 5301.0 5373.7 5527.9 5532.7 5543.8 5235.7 5281.0 5364.3 5367.0 5381.2 5370.1 5373.6 5374.9 5468.1 5476.8 5226.3 5332.8 5366.8 5386.5 5387.2 5409.4 5412.8 5419.1 5423.9 5441.7 5280.1 5304.6 5307.8 5319.2 5335.4 15:34:10 INFO - PROCESS | 12969 | 15:34:10 INFO - PROCESS | 12969 | [#5] yui.html Cycles:180 Average:20518.74 Median:4444.96 stddev:30556.32 (687.4%) stddev-sans-first:30605.62 15:34:10 INFO - PROCESS | 12969 | Values: 651.9 653.8 666.3 739.0 740.4 14685.9 16360.0 16557.3 16614.9 16617.8 14947.0 15062.7 15245.3 15256.2 15256.5 788.6 802.3 811.2 811.8 812.0 658.6 677.7 782.1 809.8 813.7 840.4 846.2 846.4 846.5 846.5 835.4 835.7 836.8 837.0 843.1 497.9 505.1 510.6 615.1 615.2 11210.8 13618.3 14125.6 14144.9 14633.9 13839.0 14687.9 14801.0 14881.9 15230.7 10516.2 10561.8 10658.9 10719.2 10899.8 3520.6 3524.2 3576.2 3593.4 3599.5 72843.3 74336.6 77335.2 77433.6 78442.0 10328.7 10335.7 10443.5 10516.0 10942.5 22062.6 22262.8 22264.6 22330.3 22355.4 7569.8 7728.0 7896.6 7915.5 8342.7 4077.6 4136.4 4144.1 4158.2 4272.1 3513.9 3630.4 3841.7 4025.8 4032.3 682.6 692.2 695.2 700.7 703.5 615.3 699.5 705.4 718.9 739.5 9007.5 9013.2 9195.6 9258.6 9330.4 567.5 601.3 651.6 657.8 673.5 4403.5 4486.4 4522.3 4571.5 4627.6 65987.7 105160.5 118150.0 125767.0 131275.0 109994.0 110768.0 110939.9 111119.0 112885.4 72953.6 86485.7 86831.1 87679.0 89227.6 9312.5 9646.8 9673.9 9723.4 9738.7 49493.5 49992.5 50658.7 51438.0 51543.2 68018.7 69465.0 73800.0 74738.0 77505.0 11932.2 12027.3 12187.4 12444.9 12706.0 12843.6 12901.9 13248.6 13293.4 13914.7 12549.0 12566.7 13163.7 13477.4 13592.4 11500.0 11805.4 11808.7 12066.3 12457.8 11097.2 11266.3 11416.8 11452.9 11615.1 9387.2 9558.9 9769.7 9964.9 10135.6 10068.2 10324.7 10401.4 10522.9 10569.5 15:34:10 INFO - PROCESS | 12969 | -------- Summary: end -------- 15:34:10 INFO - PROCESS | 12969 | 15:34:11 INFO - TEST-INFO | 12969: exit 0 15:34:11 INFO - TEST-OK | dromaeo_css | took 1117084ms 15:34:11 INFO - TEST-START | kraken 15:34:11 INFO - operating with platform_type : linux_ 15:34:11 INFO - Initialising browser for kraken test... 15:34:11 INFO - TEST-INFO | started process 13275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqZpn3/profile http://localhost:38042/getInfo.html) 15:34:15 INFO - PROCESS | 13275 | __metrics Screen width/height:1600/1200 15:34:15 INFO - PROCESS | 13275 | colorDepth:24 15:34:15 INFO - PROCESS | 13275 | Browser inner width/height: 1024/697 15:34:15 INFO - PROCESS | 13275 | __metrics 15:34:16 INFO - PROCESS | 13275 | 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" 15:34:16 INFO - PROCESS | 13275 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:17 INFO - PROCESS | 13275 | console.error: PushService: 15:34:17 INFO - PROCESS | 13275 | stateChangeProcessEnqueue: Error transitioning state 15:34:17 INFO - PROCESS | 13275 | UnknownError 15:34:17 INFO - TEST-INFO | 13275: exit 0 15:34:17 INFO - Browser initialized. 15:34:17 INFO - Running cycle 1/1 for kraken test... 15:34:17 INFO - TEST-INFO | started process 13357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqZpn3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:29 INFO - PROCESS | 13357 | RSS: Main: 174096384 15:34:29 INFO - PROCESS | 13357 | 15:34:32 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38042/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:33 INFO - PROCESS | 13357 | RSS: Main: 232595456 15:34:33 INFO - PROCESS | 13357 | 15:34:36 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38042/tests/kraken/driver.html?testName=audio-dft) 15:34:36 INFO - PROCESS | 13357 | RSS: Main: 217333760 15:34:36 INFO - PROCESS | 13357 | 15:34:39 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38042/tests/kraken/driver.html?testName=audio-fft) 15:34:40 INFO - PROCESS | 13357 | RSS: Main: 299384832 15:34:40 INFO - PROCESS | 13357 | 15:34:42 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38042/tests/kraken/driver.html?testName=audio-oscillator) 15:34:43 INFO - PROCESS | 13357 | RSS: Main: 210628608 15:34:43 INFO - PROCESS | 13357 | 15:34:45 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38042/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:45 INFO - PROCESS | 13357 | RSS: Main: 214302720 15:34:45 INFO - PROCESS | 13357 | 15:34:48 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38042/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:49 INFO - PROCESS | 13357 | RSS: Main: 249618432 15:34:49 INFO - PROCESS | 13357 | 15:34:52 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38042/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:53 INFO - PROCESS | 13357 | RSS: Main: 248946688 15:34:53 INFO - PROCESS | 13357 | 15:34:56 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38042/tests/kraken/driver.html?testName=json-parse-financial) 15:34:56 INFO - PROCESS | 13357 | RSS: Main: 248311808 15:34:56 INFO - PROCESS | 13357 | 15:34:58 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38042/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:58 INFO - PROCESS | 13357 | RSS: Main: 210526208 15:34:58 INFO - PROCESS | 13357 | 15:35:00 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:35:01 INFO - PROCESS | 13357 | RSS: Main: 218583040 15:35:01 INFO - PROCESS | 13357 | 15:35:03 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:35:03 INFO - PROCESS | 13357 | RSS: Main: 227233792 15:35:03 INFO - PROCESS | 13357 | 15:35:06 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:35:07 INFO - PROCESS | 13357 | RSS: Main: 235180032 15:35:07 INFO - PROCESS | 13357 | 15:35:10 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:35:10 INFO - PROCESS | 13357 | RSS: Main: 232898560 15:35:10 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | Cycle 1(1): loaded http://localhost:38042/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38042/tests/kraken/driver.html?testName=ai-astar) 15:35:12 INFO - PROCESS | 13357 | RSS: Main: 284889088 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | __start_tp_report 15:35:12 INFO - PROCESS | 13357 | _x_x_mozilla_page_load 15:35:12 INFO - PROCESS | 13357 | _x_x_mozilla_page_load_details 15:35:12 INFO - PROCESS | 13357 | |i|pagename|runs| 15:35:12 INFO - PROCESS | 13357 | |0;ai-astar;110;112;112;112;113;113;112;111;111;111 15:35:12 INFO - PROCESS | 13357 | |1;audio-beat-detection;148;122;122;176;124;125;123;125;158;129 15:35:12 INFO - PROCESS | 13357 | |2;audio-dft;161;161;160;161;160;162;161;163;163;162 15:35:12 INFO - PROCESS | 13357 | |3;audio-fft;75;76;77;115;76;76;75;76;103;75 15:35:12 INFO - PROCESS | 13357 | |4;audio-oscillator;83;81;119;83;83;83;103;83;83;115 15:35:12 INFO - PROCESS | 13357 | |5;imaging-gaussian-blur;116;116;116;117;117;116;117;117;117;116 15:35:12 INFO - PROCESS | 13357 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;147 15:35:12 INFO - PROCESS | 13357 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 15:35:12 INFO - PROCESS | 13357 | |8;json-parse-financial;52;51;52;51;53;52;52;51;53;51 15:35:12 INFO - PROCESS | 13357 | |9;json-stringify-tinderbox;64;64;63;63;64;63;63;63;63;63 15:35:12 INFO - PROCESS | 13357 | |10;stanford-crypto-aes;80;83;84;80;80;80;81;81;80;79 15:35:12 INFO - PROCESS | 13357 | |11;stanford-crypto-ccm;144;130;135;150;138;130;148;131;170;144 15:35:12 INFO - PROCESS | 13357 | |12;stanford-crypto-pbkdf2;167;176;166;167;171;169;165;166;171;173 15:35:12 INFO - PROCESS | 13357 | |13;stanford-crypto-sha256-iterative;65;68;67;66;67;70;64;65;64;63 15:35:12 INFO - PROCESS | 13357 | __end_tp_report 15:35:12 INFO - PROCESS | 13357 | __start_cc_report 15:35:12 INFO - PROCESS | 13357 | _x_x_mozilla_cycle_collect,1629 15:35:12 INFO - PROCESS | 13357 | __end_cc_report 15:35:12 INFO - PROCESS | 13357 | __startTimestamp1475620512762__endTimestamp 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | ------- Summary: start ------- 15:35:12 INFO - PROCESS | 13357 | Number of tests: 14 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.95 (0.8%) stddev-sans-first:0.78 15:35:12 INFO - PROCESS | 13357 | Values: 110.0 112.0 112.0 112.0 113.0 113.0 112.0 111.0 111.0 111.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:127.00 stddev:18.91 (14.9%) stddev-sans-first:19.48 15:35:12 INFO - PROCESS | 13357 | Values: 148.0 122.0 122.0 176.0 124.0 125.0 123.0 125.0 158.0 129.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 15:35:12 INFO - PROCESS | 13357 | Values: 161.0 161.0 160.0 161.0 160.0 162.0 161.0 163.0 163.0 162.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.32 (18.8%) stddev-sans-first:14.93 15:35:12 INFO - PROCESS | 13357 | Values: 75.0 76.0 77.0 115.0 76.0 76.0 75.0 76.0 103.0 75.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:83.00 stddev:14.85 (17.9%) stddev-sans-first:15.42 15:35:12 INFO - PROCESS | 13357 | Values: 83.0 81.0 119.0 83.0 83.0 83.0 103.0 83.0 83.0 115.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:35:12 INFO - PROCESS | 13357 | Values: 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:35:12 INFO - PROCESS | 13357 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 147.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:35:12 INFO - PROCESS | 13357 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 15:35:12 INFO - PROCESS | 13357 | Values: 52.0 51.0 52.0 51.0 53.0 52.0 52.0 51.0 53.0 51.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 15:35:12 INFO - PROCESS | 13357 | Values: 64.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:1.55 (1.9%) stddev-sans-first:1.62 15:35:12 INFO - PROCESS | 13357 | Values: 80.0 83.0 84.0 80.0 80.0 80.0 81.0 81.0 80.0 79.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:144.00 stddev:12.32 (8.6%) stddev-sans-first:13.05 15:35:12 INFO - PROCESS | 13357 | Values: 144.0 130.0 135.0 150.0 138.0 130.0 148.0 131.0 170.0 144.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.00 stddev:3.57 (2.1%) stddev-sans-first:3.71 15:35:12 INFO - PROCESS | 13357 | Values: 167.0 176.0 166.0 167.0 171.0 169.0 165.0 166.0 171.0 173.0 15:35:12 INFO - PROCESS | 13357 | 15:35:12 INFO - PROCESS | 13357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:2.13 (3.2%) stddev-sans-first:2.24 15:35:12 INFO - PROCESS | 13357 | Values: 65.0 68.0 67.0 66.0 67.0 70.0 64.0 65.0 64.0 63.0 15:35:12 INFO - PROCESS | 13357 | -------- Summary: end -------- 15:35:12 INFO - PROCESS | 13357 | 15:35:14 INFO - TEST-INFO | 13357: exit 0 15:35:14 INFO - TEST-OK | kraken | took 62723ms 15:35:14 INFO - SUITE-END | took 1179s 15:35:14 INFO - Completed test suite (00:19:40) 15:35:14 INFO - javascript benchmark 15:35:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.212098793819, 3020.4261190373813, 3023.576699262103, 3050.374673191996, 3071.9385612287756, 5075.9492405075935, 5134.050200712871, 5233.502817232362, 5297.682139071659, 5313.548348390386, 5095.8216462423825, 5174.715390653512, 5228.895422091556, 5285.127953887613, 5338.67967921925, 4665.2768820832825, 4724.881877953061, 4730.97634511827, 4744.240921452569, 4785.569298763111, 4733.763311834412, 4783.856484305459, 4800.927986080212, 4816.229403295473, 4835.492273311304, 4589.816407343702, 4622.815087396534, 4864.051509955542, 4908.926366104493, 4909.21452567591, 4670.673052886299, 4676.602488788457, 4677.298405239208, 4679.766011699401, 4681.368015317923, 4650.627949764011, 4654.208784506642, 4659.953400465985, 4660.697054691468, 4671.95328046722, 5017.347744793154, 5070.873228169288, 5075.492450754932, 5080.695158290514, 5081.161608334621, 5395.919061214085, 5495.477929596682, 5507.752151153168, 5586.804461843856, 5591.832245032615, 5495.395506494282, 5510.6418082824885, 5512.090505066659, 5575.275214222166, 5575.526080283181, 5216.63483556155, 5217.791288348461, 5230.503102205284, 5230.947690523122, 5244.213367994793, 5377.704226267593, 5411.107167317427, 5638.830835074954, 5669.348024977098, 5736.713164341766, 5521.089020311603, 5524.14375771756, 5534.252875861787, 5534.86162845924, 5545.334559852763, 5608.551315894719, 5612.130119831432, 5612.382637909826, 5617.354004289477, 5621.606487545914, 5294.338207724035, 5345.893082138336, 5440.265564148789, 5447.618666693373, 5525.4474552544425, 5553.583481238923, 5553.722313884289, 5556.972215138899, 5560.610757247035, 5614.63504872182, 4318.913621727611, 4320.027993701392, 4320.870373888788, 4360.716553424018, 4371.912561748747, 3725.2735716535017, 3743.7753734775456, 3767.3407153747985, 3776.546814382292, 3850.1914597934187, 5165.690058596496, 5165.974170129125, 5167.586593072545, 5170.71561064145, 5212.582993360522, 5442.91835622466, 5474.343078830486, 5487.847552014042, 5499.037668408013, 5546.972265138648, 5062.265971434195, 5064.518870707277, 5182.4299327073995, 5247.0, 5286.20706893969, 4896.975515122402, 4901.117798796179, 4901.191303434894, 4906.0, 4956.4547899731, 5745.85635359111, 5766.135079737989, 5774.0761478163295, 5841.970790146107, 5843.94156058434, 5323.414424413389, 5391.379991300893, 5437.782488700566, 5656.971715141398, 5663.716814159358, 5676.574256930664, 5701.828945131652, 5704.572157088152, 5752.511036561939, 5770.13447982806, 5444.1017232156255, 5444.1017232156255, 5445.1832225166545, 5445.863853403696, 5450.182472629137, 5321.255024296524, 5339.4660533947845, 5502.862428439321, 5527.364353099445, 5587.916181257203, 5331.280277162688, 5345.65253258537, 5399.217113518596, 5417.214503896992, 5444.428335024765, 5407.86480337979, 5411.594130440311, 5417.945820541744, 5423.538999185113, 5423.5932305076485, 5212.4005739338945, 5389.299391079291, 5402.486763757437, 5404.891902162013, 5465.672059676433, 5309.256704061358, 5337.759800808895, 5408.972955135199, 5412.56699464034, 5494.505494505353, 5303.124984377535, 5320.52115309624, 5322.946770532245, 5329.9467005331, 5330.78676852937], "value": 5108.116453791105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.76405909518, 594.598645914008, 604.190384884255, 618.4773866083161, 628.1614045249592, 31196.22009449762, 32215.67784322159, 34327.82836085816, 34392.656073439226, 41251.58748412515, 43591.025435930256, 43827.342589861175, 43914.78042609782, 43938.7803060985, 43981.56018439815, 8903.777405564848, 9055.683051093212, 9055.683051093212, 9063.274938004944, 9063.45619262843, 8762.386632935697, 8870.556472176399, 8875.245604123656, 8875.68935087272, 8876.556172191396, 8890.644374225056, 8941.821163576724, 8943.731688049369, 8945.731628051137, 8947.194752472276, 8843.425177363451, 8883.600237989305, 8889.955550222208, 8892.644294228223, 8898.0, 8577.614007369682, 8709.303255739525, 8717.4333668312, 8721.30229581632, 8729.127087291283, 40770.0, 40898.79550602258, 41074.794626026975, 41125.58874411247, 41354.1729165418, 3096.427160975227, 3171.175494371457, 3235.6440791512914, 3263.0863358259726, 3599.2441587266703, 28408.28979275514, 28842.855785721145, 28863.278418039507, 28883.711162888314, 29064.273393165127, 3923.195744872294, 3983.7609743415487, 4082.7346222495444, 4116.629503344683, 4163.687723420756, 317842.0, 317943.0, 318549.0, 318651.0, 318709.0, 45591.54408455939, 46976.0, 52477.0, 52627.73686131621, 52846.47153528415, 47297.527024729316, 47746.28380574294, 48112.5188748115, 48338.0, 48394.274085888035, 16626.916865415595, 16768.664626707643, 16792.748108778378, 16794.0, 16798.160091995353, 13146.802797958038, 13244.470221191044, 13255.204687718575, 13255.403506842214, 13262.679031169506, 13269.213465172228, 13687.520936767165, 14672.0, 15209.0, 15236.847631523542, 5571.331440227118, 5869.354371019184, 5887.470127688529, 5943.732532036069, 5971.0, 846.2005594879072, 856.5759948825371, 949.9857502137473, 1039.0077476010392, 1040.7190058684114, 28472.145835624964, 29207.85396073006, 29446.705532944397, 29896.701032989393, 29955.0, 991.3011327014437, 1030.3766221436074, 1053.099599842124, 1105.2484310668663, 1131.4795194210756, 15063.774043389358, 15553.911226214283, 15715.607109822116, 15739.370425182864, 16045.839541604435, 461094.0, 465615.0, 467066.0, 467286.0, 467305.0, 54329.185062224096, 54500.0, 54538.0, 54553.45446545484, 54566.0, 1321.5572783117764, 1324.6555895467247, 1354.0251019266113, 1354.4988354308969, 1356.9253691047088, 27675.308117297227, 28468.85765571159, 29055.128346148802, 29311.560326595543, 29410.411791764473, 46701.76649116733, 46921.0, 46973.295400568335, 47034.29448558343, 47042.29436558386, 426194.0, 427645.0, 428902.0, 429292.0, 430240.0, 23105.537889241783, 24020.87989560041, 26188.607170892832, 26349.34126646849, 26762.330941726614, 42445.0, 43156.78421607872, 44002.55997440113, 44469.77765111154, 45057.0, 36546.451803222444, 37066.8146659265, 38108.42837357497, 38615.6138438612, 39296.0, 36885.0, 37223.25553488969, 37687.0, 37931.81034094812, 39284.80357598194, 37221.627783721815, 38684.61315386923, 40322.79838600788, 41032.384514231715, 41157.382639261035, 39386.0, 39733.80133099432, 40140.7992960045, 41222.58777412187, 41321.0, 30579.2355191122, 31952.36095278128, 32119.678803211667, 32502.349953000336, 32703.509447357832], "value": 18866.9878460765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.9216156768647, 396.18781497929257, 403.2680684557529, 407.3218091877025, 421.4647397804788, 14099.647508812259, 17097.91451042746, 17522.824771752294, 19238.422847314585, 19268.518287042814, 17833.46499605014, 18813.247470101214, 19564.41306760796, 19709.40871773849, 19889.104990275435, 5348.5453736432255, 5393.7033463159605, 5506.697131657757, 5532.170174473841, 5540.63985840919, 4079.755214687128, 5524.530414914717, 5554.222408862763, 5600.691961942091, 5606.747696353674, 4409.757463339515, 6145.139680444719, 6230.875382492348, 6232.844178895519, 6241.1574437451045, 6170.475509581668, 6245.219347581552, 6252.218472690914, 6254.280757712831, 6287.96856015717, 5413.648112872651, 5524.392316845144, 5544.112941929312, 5545.1682247663175, 5553.861153471195, 22134.0, 22942.31173064794, 22986.42533936665, 23080.538389232122, 23206.3038108857, 2212.2920665387082, 2284.805791507724, 2432.2946345559767, 2672.0113557983477, 2883.6539615246306, 13246.337683115806, 14057.367418466194, 14178.922362058036, 14301.499447519287, 14575.416983320654, 1806.4400035988886, 1813.9909300453414, 1816.2644129127725, 1845.151230434002, 1862.7705714228543, 80362.0, 80405.0, 81335.0, 82237.0, 82859.0, 9974.900250997542, 10152.847707284396, 10373.302941235333, 10430.37417754937, 10452.843207351896, 12761.68095797594, 14980.625484362978, 14981.625459363604, 14981.775273370908, 14993.775093373608, 7515.473916825879, 7595.0, 7893.802654933673, 8012.559309238048, 8056.113827478973, 7700.961495192488, 7723.729669461542, 7949.880751788728, 7963.960180199178, 8032.518048917083, 6269.216347956505, 6410.294867564564, 6458.418742313214, 6509.218893732783, 6549.9345006550275, 1862.32956135791, 1878.3238034307637, 1898.2691663709572, 1937.2832052140516, 1964.3910387779833, 838.6603425612636, 979.1432496565506, 980.2550061952825, 983.2036050798876, 1033.617561502234, 17536.932058971706, 18880.622387552172, 19223.61552768937, 19455.0, 19475.51311217231, 953.609020301673, 965.9034096590285, 969.2021300487494, 979.7942432089199, 985.9161971232526, 9794.95102524497, 10711.0, 10915.126789856793, 10986.0, 11000.504977276041, 355852.0, 358632.0, 360523.0, 452667.0, 473827.0, 88669.0, 91415.00237458418, 92010.53994729984, 92663.5366823175, 93037.53481232686, 992.8957459466652, 1010.1312870930993, 1012.7771890184148, 1027.465717826741, 1037.7094413564214, 16169.514914552583, 16383.754243686115, 16581.91709041447, 16869.746953795457, 17026.65946681084, 29830.55254171146, 40622.18755624812, 40768.79615602022, 42180.15639687128, 42347.364789527564, 42967.57032429761, 52405.21392179044, 52507.47492525026, 53382.73308633432, 56891.354877409045, 7790.454668173174, 7944.324732397811, 8108.729555724407, 8201.71294004707, 8512.489250644981, 11988.700282492659, 12148.817767733668, 12279.140460167702, 12657.0, 12855.485780568673, 11192.921946464787, 11266.83099753488, 11362.14783891228, 11752.23610465317, 11878.346690931736, 6554.606723596599, 11088.501017454073, 11185.608503702331, 11231.71920701989, 11426.82859757121, 11308.151888608223, 11372.54509819598, 11627.883721163018, 11732.530698771954, 12005.63983080509, 8008.11910689812, 8110.756677299691, 8133.471324363897, 8285.0, 8381.203785640355, 8639.740807775777, 10793.136549075898, 10960.451977401257, 11122.721931951766, 11520.769584608428], "value": 9073.323613773638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.0666420158998, 1480.4300344367418, 1604.7432410814265, 1718.5617667494787, 1738.2091148527413, 8132.227438393358, 8436.282915952152, 8736.8689469658, 9399.436033837967, 9473.289503287264, 8790.384673072887, 9191.310651701133, 9239.722808315744, 9505.477198754066, 9512.23902087833, 2296.311106667997, 2341.0, 2341.086976079322, 2348.6124789409814, 2351.6825228594175, 1928.4793105861409, 1998.6802111662064, 2290.7938285554296, 2359.339384972202, 2371.2530552875874, 2178.0852042142337, 2266.0, 2267.637178051512, 2278.9544209115807, 2284.4060544258527, 2317.2237300504185, 2322.291701031185, 2324.5583339165505, 2331.813454923602, 2335.486193037529, 2303.4356582637192, 2320.9767902320928, 2339.099446713011, 2340.9297721068397, 2343.437574982009, 9193.540322983825, 9345.485998270093, 9350.064993500664, 9371.625134994592, 9376.765580860465, 5086.720230387327, 5213.895722085537, 5236.162214045772, 5240.423553409122, 5243.895122097537, 3176.4600017996995, 3191.5850939377965, 3326.284848757529, 3340.682635149657, 3360.24394511233, 1022.8210063238903, 1051.8737751469796, 1060.1677683018793, 1062.0919114157361, 1069.3263244156133, 13151.671208219776, 13175.34123293841, 13260.071794974356, 13263.403146858318, 13290.335483225897, 4262.296721041055, 4266.0, 4425.5574442556135, 4432.069265454226, 4566.657500687462, 10915.617953371593, 10941.4529273536, 10950.39772812487, 10955.287906286067, 10962.287451315799, 5218.765155568009, 5223.059849227176, 5231.24146998683, 5232.136697444879, 5233.241180028875, 4737.336772851803, 4802.159622066124, 4811.08589368019, 4822.035592881438, 4826.565609095128, 3819.255245227154, 3843.865464708778, 3883.203943191639, 3923.372260438316, 3956.7823769692945, 1102.2669924500117, 1132.9320240785414, 1151.090638395658, 1189.6966273600176, 1207.4264724256084, 721.6427868205272, 827.8054657155564, 848.253536887535, 852.7100785732881, 872.5549969515592, 5542.140968149944, 5568.693721845338, 5630.3402788188005, 5672.914906276409, 5722.0, 865.5931712095305, 881.0572687224608, 929.9163075323254, 930.2000279759537, 949.8100379923904, 3707.796071216109, 3740.2893450244364, 3743.6630703236838, 3749.49381833449, 3772.86794962175, 11356.94321528387, 11854.822177667342, 11863.347515886537, 11897.524099035942, 11907.345096019802, 11760.176787624785, 11829.231099978473, 11836.0, 11870.169088163746, 11873.940630296966, 8034.076081250614, 8099.433039687166, 8189.79525511867, 8196.83606327882, 8197.221263979913, 5443.945560544502, 5502.697351645698, 5521.171824226398, 5637.689927054052, 5640.633358831663, 10530.420826854597, 10546.947265263625, 10556.366618002945, 10684.0, 10716.35701857891, 10488.528016239135, 10590.417527036087, 10610.734731631463, 10838.891611083789, 10944.671659850217, 7783.1827658097345, 7922.762317130495, 7928.682852685828, 7935.2064793520185, 7942.761717148494, 8332.125126861834, 8665.566721663765, 8732.0, 8847.601857916537, 8927.24118449939, 6756.966215168893, 7676.424268179797, 7741.419393545394, 8032.437729358889, 8082.919170808452, 7550.66022028999, 7739.071311442663, 7746.225377462434, 7753.457257991887, 7795.298423141944, 6387.776427825004, 6583.210014798255, 6586.341365863375, 6892.138482689664, 6907.171139463297, 5070.442251352422, 5180.507851754077, 5198.298229738937, 5217.556507696889, 5227.954409118115, 4906.0, 4986.002799440054, 5127.820526281562, 5156.278121063129, 5184.766685499237], "value": 4611.623318369025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.35478285169637, 332.854978872678, 339.8504657950502, 341.8735068024831, 345.7441493294962, 5019.774110165043, 5149.588032957364, 5172.948270517294, 5210.478952104792, 5250.1074817281105, 4936.975315123419, 5086.186210206368, 5106.5148810863, 5108.310378098956, 5114.590832733382, 4051.2910240707906, 4066.1054567994993, 4081.469408976829, 4087.305158123111, 4090.754554726711, 3914.0022050716643, 4079.898002549945, 4085.9182816343655, 4090.7750073745933, 4112.897177570555, 4061.289274376987, 4074.5110586729484, 4089.652379547727, 4094.651954583849, 4096.97951510242, 4045.575214602454, 4053.7770422626745, 4056.452378928851, 4066.0, 4077.408775727503, 3670.687991520724, 3674.1733110050027, 3679.521662183926, 3686.594474607791, 3697.9445308320396, 4793.0, 4980.705016695649, 5007.974960125212, 5047.848564543069, 5081.644284900059, 4586.518415566385, 4596.724196548218, 4614.792334344963, 4621.867642427593, 4632.536746325341, 5332.813351532716, 5345.465453454663, 5349.0, 5349.893002139975, 5355.0896347621, 3704.0738815815894, 3871.825767840454, 3910.4720862683744, 3927.1163988102735, 3928.116173860887, 5552.91670624941, 5554.833354999357, 5595.328560572717, 5609.747561359708, 5619.409961953977, 4026.2953983053435, 4050.311447054008, 4060.837566497307, 4065.2682517146604, 4067.254603142867, 3997.560268370477, 4079.204555111784, 4104.261232978092, 4114.732542384735, 4117.279476091672, 4610.631149508032, 4612.76936153191, 4613.30800379939, 4630.21286381316, 4641.74470404131, 5418.106012507971, 5438.483344082306, 5442.482964118402, 5461.5357694596405, 5479.5342395896, 1313.5993521975697, 1328.8206092177625, 1381.1505923856755, 1381.171297221679, 1403.4947418929178, 884.8186121845006, 893.6068130022769, 900.8423525882944, 905.090259552344, 917.9265658747285, 4475.225360276584, 4516.3902873112365, 4523.0324808707655, 4526.977365113154, 4576.908461830745, 4768.758683418788, 4773.451053128865, 4781.617470602413, 4808.543188397167, 4819.831305904277, 4507.504174540798, 4525.208088584484, 4541.866112382446, 4569.794359253841, 4575.359449677047, 2432.9878350608133, 2585.948281034369, 2595.6762051353944, 2599.935001624937, 2600.8049396295355, 5012.248162775612, 5015.974920125376, 5019.498050195024, 5045.678987665715, 5051.444341122474, 4941.950580494149, 4949.331840201598, 4953.653244272867, 4954.925676114861, 5005.224190250517, 5374.0, 5745.88508229833, 5764.394738552475, 5765.88468230633, 5769.884602307847, 5571.526420254324, 5573.665580065209, 5574.9163762542785, 5580.990843296491, 5581.944180558143, 5230.34620672416, 5487.670739755467, 5496.477834605706, 5517.310336207974, 5554.805581804618, 5737.8565535861935, 5739.454751798572, 5742.511886489695, 5750.741216645178, 5778.104393818965, 3927.8821635350987, 3942.6845852332317, 3950.7234493585174, 3952.446657467899, 3963.4649322341115, 5301.0, 5373.704446255337, 5527.944720552743, 5532.6680399176175, 5543.750531226024, 5235.65968212065, 5280.973595132, 5364.275822763877, 5366.973165134305, 5381.165919282517, 5370.113931201308, 5373.570114390761, 5374.919376209282, 5468.0977638690765, 5476.80831170923, 5226.346706661668, 5332.78668853257, 5366.838994830161, 5386.5152136307925, 5387.218853266176, 5409.377921539073, 5412.78348866041, 5419.132938729785, 5423.891522169613, 5441.700706461183, 5280.075986702235, 5304.628675992643, 5307.761150748149, 5319.175527793198, 5335.413104558418], "value": 4047.903935366006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.9119918810962, 653.8365408647837, 666.2604508995017, 738.9815254618634, 740.4298690008693, 14685.853141468595, 16360.018398896074, 16557.337706491726, 16614.91692541537, 16617.83382166178, 14947.028443151188, 15062.698746025073, 15245.31396087176, 15256.160911149882, 15256.466023689172, 788.6293442082213, 802.3100133884855, 811.2252798577344, 811.8457493076326, 812.0052935154448, 658.5521845145323, 677.6713294052381, 782.0693374883898, 809.7692157735047, 813.7477382011566, 840.357126798, 846.2468403121227, 846.3948276981956, 846.4963346808639, 846.5090247656375, 835.3734698975768, 835.6907944060737, 836.8410002099581, 837.0457678246803, 843.1273631791097, 497.93028975943395, 505.08327385794666, 510.58132331487826, 615.1449485215554, 615.2063837649426, 11210.775784484345, 13618.250996195206, 14125.576232713034, 14144.929275353661, 14633.853661463356, 13839.0, 14687.853121468755, 14801.0, 14881.925590372088, 15230.695386092217, 10516.211284153642, 10561.841572376421, 10658.946705266502, 10719.196060295431, 10899.83650245247, 3520.577530696333, 3524.1894364296354, 3576.213233088716, 3593.3711600469815, 3599.5140656011627, 72843.27156728417, 74336.62831685807, 77335.22664773336, 77433.61283193604, 78442.0, 10328.690139295833, 10335.74160645975, 10443.477826108665, 10516.0, 10942.45887956505, 22062.558748825253, 22262.777372226396, 22264.554708905733, 22330.330090097323, 22355.441113971956, 7569.772906812805, 7728.0, 7896.565688887166, 7915.525068495794, 8342.66629334832, 4077.55146933837, 4136.358864376027, 4144.089556834716, 4158.189153115174, 4272.124214536075, 3513.894583162509, 3630.364686179908, 3841.7118716096406, 4025.75845449274, 4032.2540330039037, 682.6245564939263, 692.2247083266774, 695.2421860172436, 700.7477308169055, 703.4513079797766, 615.2893408113636, 699.5418001209216, 705.4074577355046, 718.9352958233784, 739.5193124469031, 9007.549622518847, 9013.18881300686, 9195.63217471307, 9258.583363748512, 9330.440173589606, 567.5289509706934, 601.2721129000216, 651.5894986158689, 657.7599176300616, 673.4574452257945, 4403.471583410012, 4486.439195100613, 4522.276435770261, 4571.51999040096, 4627.629789616823, 65987.67006164939, 105160.47419763006, 118150.0, 125767.0, 131275.0, 109994.0, 110768.0, 110939.89060109456, 111119.0, 112885.4355728216, 72953.6352318235, 86485.70271445933, 86831.13168868357, 87679.0, 89227.55386223027, 9312.534373281173, 9646.758831029281, 9673.903260967581, 9723.367981081206, 9738.707838764849, 49493.50506494889, 49992.50007499878, 50658.74670626623, 51438.0, 51543.226851598, 68018.65990670015, 69465.0, 73800.0, 74738.0, 77505.0, 11932.16474846787, 12027.338496382783, 12187.390630468619, 12444.937775311428, 12706.0, 12843.550475733304, 12901.935490322863, 13248.602541923758, 13293.401796919356, 13914.652133696738, 12549.0, 12566.685832854251, 13163.67090822737, 13477.39351729155, 13592.388342524413, 11500.0, 11805.409729513662, 11808.70478238051, 12066.336351500751, 12457.819881520878, 11097.223194376316, 11266.324020558794, 11416.771664566497, 11452.885471145182, 11615.128865334964, 9387.202087822612, 9558.904410955802, 9769.658061967797, 9964.850527241952, 10135.645252416425, 10068.24488163376, 10324.690259292232, 10401.375917444675, 10522.894771052192, 10569.524371403151], "value": 7241.970865715745, "unit": "score"}], "name": "dromaeo_css", "value": 7005.718058098716, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 122.0, 176.0, 124.0, 125.0, 123.0, 125.0, 158.0, 129.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 163.0, 163.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 115.0, 76.0, 76.0, 75.0, 76.0, 103.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 119.0, 83.0, 83.0, 83.0, 103.0, 83.0, 83.0, 115.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 53.0, 52.0, 52.0, 51.0, 53.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 84.0, 80.0, 80.0, 80.0, 81.0, 81.0, 80.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 130.0, 135.0, 150.0, 138.0, 130.0, 148.0, 131.0, 170.0, 144.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 176.0, 166.0, 167.0, 171.0, 169.0, 165.0, 166.0, 171.0, 173.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 66.0, 67.0, 70.0, 64.0, 65.0, 64.0, 63.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1512.6999999999998, "alertThreshold": 2.0}]} 15:35:14 INFO - Return code: 0 15:35:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:35:14 INFO - # TBPL SUCCESS # 15:35:14 INFO - Running post-action listener: _resource_record_post_action 15:35:14 INFO - [mozharness: 2016-10-04 22:35:14.575439Z] Finished run-tests step (success) 15:35:14 INFO - Running post-run listener: _resource_record_post_run 15:35:14 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393273344; Read time: 16; Write time: 420868 15:35:14 INFO - TinderboxPrint: CPU usage
13.1% 15:35:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:35:14 INFO - TinderboxPrint: I/O write bytes / time
393,273,344 / 420,868 15:35:14 INFO - TinderboxPrint: CPU idle
8,302.4 (86.9%) 15:35:14 INFO - TinderboxPrint: CPU user
1,195.9 (12.5%) 15:35:14 INFO - TinderboxPrint: Swap in / out
0 / 0 15:35:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103047168; Read time: 0; Write time: 91000 15:35:14 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289251328; Read time: 0; Write time: 329836 15:35:15 INFO - Running post-run listener: _upload_blobber_files 15:35:15 INFO - Blob upload gear active. 15:35:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:35:15 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 15:35:15 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:35:15 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:35:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:19 INFO - (blobuploader) - INFO - Done attempting. 15:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:20 INFO - (blobuploader) - INFO - Done attempting. 15:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:35:21 INFO - (blobuploader) - INFO - Done attempting. 15:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:35:21 INFO - Return code: 0 15:35:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd1a0bd01b711de2195f0d6cb0751652ec704234b1f3f9c445b5ee92c40977aa8f93cf137da4f531d00acb3abf5ab85597b22a86e01e7773b7b6fe89d926aa5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0ce5332a971d874e5fa344068117722534c59c9000584222388cd3e187c0ecb18b014d2b805550f7cbfdf8e1f14a3b71104d8111dc5f658a1b0f896811c367c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716182293925e047bad92c2923ac07b09ea77720ebb5b07e73cb31692dd0099e15077686e8b7b7be092760a33994a3a401d93d7dca08c679efc8294eaceb6445"} 15:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:35:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:35:21 INFO - Contents: 15:35:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd1a0bd01b711de2195f0d6cb0751652ec704234b1f3f9c445b5ee92c40977aa8f93cf137da4f531d00acb3abf5ab85597b22a86e01e7773b7b6fe89d926aa5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0ce5332a971d874e5fa344068117722534c59c9000584222388cd3e187c0ecb18b014d2b805550f7cbfdf8e1f14a3b71104d8111dc5f658a1b0f896811c367c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716182293925e047bad92c2923ac07b09ea77720ebb5b07e73cb31692dd0099e15077686e8b7b7be092760a33994a3a401d93d7dca08c679efc8294eaceb6445"} 15:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:35:21 INFO - Copying logs to upload dir... 15:35:21 INFO - mkdir: /builds/slave/test/build/upload/logs 15:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.566568 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-04 15:35:21.294659) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 15:35:21.299669) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311 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/sha512/fd1a0bd01b711de2195f0d6cb0751652ec704234b1f3f9c445b5ee92c40977aa8f93cf137da4f531d00acb3abf5ab85597b22a86e01e7773b7b6fe89d926aa5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0ce5332a971d874e5fa344068117722534c59c9000584222388cd3e187c0ecb18b014d2b805550f7cbfdf8e1f14a3b71104d8111dc5f658a1b0f896811c367c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716182293925e047bad92c2923ac07b09ea77720ebb5b07e73cb31692dd0099e15077686e8b7b7be092760a33994a3a401d93d7dca08c679efc8294eaceb6445"} build_url:https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/FgSYbKgQQUKhkNAVtrliAw/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/sha512/fd1a0bd01b711de2195f0d6cb0751652ec704234b1f3f9c445b5ee92c40977aa8f93cf137da4f531d00acb3abf5ab85597b22a86e01e7773b7b6fe89d926aa5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0ce5332a971d874e5fa344068117722534c59c9000584222388cd3e187c0ecb18b014d2b805550f7cbfdf8e1f14a3b71104d8111dc5f658a1b0f896811c367c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/716182293925e047bad92c2923ac07b09ea77720ebb5b07e73cb31692dd0099e15077686e8b7b7be092760a33994a3a401d93d7dca08c679efc8294eaceb6445"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 15:35:21.330760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:35:21.331192) ========= 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=5bd038846534b2fdfa68eeae000001e2-1475619276.176555-169281311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004759 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:35:21.382708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 15:35:21.383132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 15:35:21.383516) ========= ========= Total master_lag: 0.48 =========