builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1477248134.85 results: success (0) buildid: 20161023101823 builduid: ffe726756e534fc5a328795ea7cbc5cc revision: a9a41b69f3f9be494ae0653601c08aa388d9afe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.855151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.855683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.856002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.872661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.872975) ========= 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=836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-23 11:42:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-23 11:42:15 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078214 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.970752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:14.971087) ========= 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=836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:15.021298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 11:42:15.021756) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a9a41b69f3f9be494ae0653601c08aa388d9afe4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a9a41b69f3f9be494ae0653601c08aa388d9afe4 --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=836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-23 11:42:15,561 truncating revision to first 12 chars 2016-10-23 11:42:15,561 Setting DEBUG logging. 2016-10-23 11:42:15,561 attempt 1/10 2016-10-23 11:42:15,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a9a41b69f3f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 11:42:16,851 unpacking tar archive at: mozilla-central-a9a41b69f3f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.620207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 11:42:16.656168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:16.656543) ========= script_repo_revision: a9a41b69f3f9be494ae0653601c08aa388d9afe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:16.656997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:16.657326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 11:42:16.667291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-23 11:42:16.667674) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:17 INFO - MultiFileLogger online at 20161023 11:42:17 in /builds/slave/test 11:42:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:17 INFO - {'append_to_log': False, 11:42:17 INFO - 'base_work_dir': '/builds/slave/test', 11:42:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:17 INFO - 'branch': 'Firefox-Non-PGO', 11:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:17 INFO - 'config_files': ('talos/linux_config.py',), 11:42:17 INFO - 'default_actions': ('clobber', 11:42:17 INFO - 'read-buildbot-config', 11:42:17 INFO - 'download-and-extract', 11:42:17 INFO - 'populate-webroot', 11:42:17 INFO - 'create-virtualenv', 11:42:17 INFO - 'install', 11:42:17 INFO - 'run-tests'), 11:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:17 INFO - 'download_minidump_stackwalk': True, 11:42:17 INFO - 'download_symbols': 'ondemand', 11:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:17 INFO - 'installer_path': 'installer.exe', 11:42:17 INFO - 'log_level': 'info', 11:42:17 INFO - 'log_name': 'talos', 11:42:17 INFO - 'log_to_console': True, 11:42:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:17 INFO - 'opt_config_files': (), 11:42:17 INFO - 'pip_index': False, 11:42:17 INFO - 'sps_profile': False, 11:42:17 INFO - 'sps_profile_interval': 0, 11:42:17 INFO - 'suite': 'dromaeojs-e10s', 11:42:17 INFO - 'system_bits': '32', 11:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:17 INFO - 'title': 'talos-linux64-ix-028', 11:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:17 INFO - 'use_talos_json': True, 11:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:17 INFO - 'work_dir': 'build'} 11:42:17 INFO - [mozharness: 2016-10-23 18:42:17.306932Z] Running clobber step. 11:42:17 INFO - Running pre-action listener: _resource_record_pre_action 11:42:17 INFO - Running main action method: clobber 11:42:17 INFO - rmtree: /builds/slave/test/build 11:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:18 INFO - Running post-action listener: _resource_record_post_action 11:42:18 INFO - [mozharness: 2016-10-23 18:42:18.273714Z] Finished clobber step (success) 11:42:18 INFO - [mozharness: 2016-10-23 18:42:18.273813Z] Running read-buildbot-config step. 11:42:18 INFO - Running pre-action listener: _resource_record_pre_action 11:42:18 INFO - Running main action method: read_buildbot_config 11:42:18 INFO - Using buildbot properties: 11:42:18 INFO - { 11:42:18 INFO - "project": "", 11:42:18 INFO - "product": "firefox", 11:42:18 INFO - "script_repo_revision": "production", 11:42:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:42:18 INFO - "repository": "", 11:42:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:42:18 INFO - "buildid": "20161023101823", 11:42:18 INFO - "pgo_build": "False", 11:42:18 INFO - "basedir": "/builds/slave/test", 11:42:18 INFO - "buildnumber": 250, 11:42:18 INFO - "slavename": "talos-linux64-ix-028", 11:42:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:42:18 INFO - "platform": "ubuntu64_hw", 11:42:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 11:42:18 INFO - "branch": "mozilla-central", 11:42:18 INFO - "repo_path": "mozilla-central", 11:42:18 INFO - "revision": "a9a41b69f3f9be494ae0653601c08aa388d9afe4", 11:42:18 INFO - "stage_platform": "linux64", 11:42:18 INFO - "builduid": "ffe726756e534fc5a328795ea7cbc5cc", 11:42:18 INFO - "slavebuilddir": "test" 11:42:18 INFO - } 11:42:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:42:18 INFO - Running post-action listener: _resource_record_post_action 11:42:18 INFO - [mozharness: 2016-10-23 18:42:18.276232Z] Finished read-buildbot-config step (success) 11:42:18 INFO - [mozharness: 2016-10-23 18:42:18.276319Z] Running download-and-extract step. 11:42:18 INFO - Running pre-action listener: _resource_record_pre_action 11:42:18 INFO - Running main action method: download_and_extract 11:42:18 INFO - mkdir: /builds/slave/test/build/tests 11:42:18 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')]} 11:42:18 INFO - trying https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:42:18 INFO - Downloading https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/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 11:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/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 11:42:18 INFO - Downloaded 1361 bytes. 11:42:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:42:18 INFO - Using the following test package requirements: 11:42:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:42:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'jsshell-linux-x86_64.zip'], 11:42:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:42:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:42:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:42:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:18 INFO - Fetch https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:42:19 INFO - Http code: 200 11:42:19 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 11:42:19 INFO - x-amz-cf-id: Icuirr2SvbOHLsoOFgPR6cfU6jTQqOwv8UViD7w7p0kCUmHted9DKQ== 11:42:19 INFO - x-amz-version-id: WBhtusdQ.5y6CwUNc.hSVComqa3OGqkj 11:42:19 INFO - Expected file size: 20470256 11:42:19 INFO - Obtained file size: 20470256 11:42:23 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 11:42:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:42:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:23 INFO - Fetch https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:42:24 INFO - Http code: 200 11:42:24 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 11:42:24 INFO - x-amz-cf-id: bdaBfft1c0PCt1GQwmCLg6jgplVsyKdo8c8_pyNT2XVKWw7I3r4v3w== 11:42:24 INFO - x-amz-version-id: WBhtusdQ.5y6CwUNc.hSVComqa3OGqkj 11:42:24 INFO - Expected file size: 20470256 11:42:24 INFO - Obtained file size: 20470256 11:42:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:42:29 INFO - Fetch https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:42:29 INFO - Http code: 200 11:42:29 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 11:42:29 INFO - x-amz-cf-id: bYBIHUMev7Eziuw2x3FqTNKq6Wr4uMRE5753OqksfaDoph81XsuztQ== 11:42:29 INFO - x-amz-version-id: SMLHovFmaMwAYtsen5YozdsoIoPbK1J8 11:42:29 INFO - Expected file size: 14409028 11:42:29 INFO - Obtained file size: 14409028 11:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:30 INFO - trying https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:42:30 INFO - Downloading https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/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 11:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/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 11:42:31 INFO - Downloaded 55583413 bytes. 11:42:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:42:31 INFO - mkdir: /builds/slave/test/properties 11:42:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:31 INFO - Contents: 11:42:31 INFO - build_url:https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:42:31 INFO - Running post-action listener: _resource_record_post_action 11:42:31 INFO - Running post-action listener: set_extra_try_arguments 11:42:31 INFO - [mozharness: 2016-10-23 18:42:31.982024Z] Finished download-and-extract step (success) 11:42:31 INFO - [mozharness: 2016-10-23 18:42:31.982249Z] Running populate-webroot step. 11:42:31 INFO - Running pre-action listener: _resource_record_pre_action 11:42:31 INFO - Running main action method: populate_webroot 11:42:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:31 INFO - '--tppagecycles', 11:42:31 INFO - '7'], 11:42:31 INFO - 'tests': ['tsvgm']}}, 11:42:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:42:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:42:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:42:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['damp', 'tps']}, 11:42:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'tests': ['damp', 'tps']}, 11:42:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['dromaeo_dom']}, 11:42:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['basic_compositor_video']}, 11:42:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:42:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['a11yr', 11:42:31 INFO - 'ts_paint', 11:42:31 INFO - 'tpaint', 11:42:31 INFO - 'sessionrestore', 11:42:31 INFO - 'sessionrestore_no_auto_restore', 11:42:31 INFO - 'tabpaint']}, 11:42:31 INFO - 'other-e10s': {'tests': ['a11yr', 11:42:31 INFO - 'ts_paint', 11:42:31 INFO - 'tpaint', 11:42:31 INFO - 'sessionrestore', 11:42:31 INFO - 'sessionrestore_no_auto_restore', 11:42:31 INFO - 'tabpaint']}, 11:42:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:42:31 INFO - 'ts_paint', 11:42:31 INFO - 'tpaint', 11:42:31 INFO - 'sessionrestore', 11:42:31 INFO - 'sessionrestore_no_auto_restore', 11:42:31 INFO - 'tabpaint']}, 11:42:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:42:31 INFO - 'ts_paint', 11:42:31 INFO - 'tpaint', 11:42:31 INFO - 'sessionrestore', 11:42:31 INFO - 'sessionrestore_no_auto_restore', 11:42:31 INFO - 'tabpaint']}, 11:42:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['a11yr', 11:42:31 INFO - 'ts_paint', 11:42:31 INFO - 'tpaint', 11:42:31 INFO - 'sessionrestore', 11:42:31 INFO - 'sessionrestore_no_auto_restore', 11:42:31 INFO - 'tabpaint']}, 11:42:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['a11yr', 11:42:31 INFO - 'ts_paint', 11:42:31 INFO - 'tpaint', 11:42:31 INFO - 'sessionrestore', 11:42:31 INFO - 'sessionrestore_no_auto_restore', 11:42:31 INFO - 'tabpaint']}, 11:42:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['tsvgx', 11:42:31 INFO - 'tsvgr_opacity', 11:42:31 INFO - 'tart', 11:42:31 INFO - 'tscrollx', 11:42:31 INFO - 'cart']}, 11:42:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:42:31 INFO - 'tsvgr_opacity', 11:42:31 INFO - 'tart', 11:42:31 INFO - 'tscrollx', 11:42:31 INFO - 'cart']}, 11:42:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'talos_options': ['--disable-e10s'], 11:42:31 INFO - 'tests': ['tp5o']}, 11:42:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'tests': ['tp5o']}, 11:42:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'talos_options': ['--disable-e10s', 11:42:31 INFO - '--xperf_path', 11:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:31 INFO - 'tests': ['tp5n']}, 11:42:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:31 INFO - 'talos_options': ['--xperf_path', 11:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:31 INFO - 'tests': ['tp5n']}}, 11:42:31 INFO - 'talos.zip': {'path': '', 11:42:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:31 INFO - Running post-action listener: _resource_record_post_action 11:42:32 INFO - [mozharness: 2016-10-23 18:42:31.999986Z] Finished populate-webroot step (success) 11:42:32 INFO - [mozharness: 2016-10-23 18:42:32.000074Z] Running create-virtualenv step. 11:42:32 INFO - Running pre-action listener: _resource_record_pre_action 11:42:32 INFO - Running main action method: create_virtualenv 11:42:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:42:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:32 INFO - Using real prefix '/usr' 11:42:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:34 INFO - Installing pip.................done. 11:42:34 INFO - Return code: 0 11:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:42:34 INFO - Reading from file tmpfile_stdout 11:42:34 INFO - Output received: 11:42:34 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) 11:42:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:34 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')]} 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:34 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')]} 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:34 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 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:34 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 11:42:34 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 11:42:34 INFO - Using env: {'DISPLAY': ':0', 11:42:34 INFO - 'HOME': '/home/cltbld', 11:42:34 INFO - 'LANG': 'en_US.UTF-8', 11:42:34 INFO - 'LANGUAGE': 'en_US:en', 11:42:34 INFO - 'LOGNAME': 'cltbld', 11:42:34 INFO - 'MAIL': '/var/mail/cltbld', 11:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:34 INFO - 'MOZ_NO_REMOTE': '1', 11:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:34 INFO - 'NO_EM_RESTART': '1', 11:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:34 INFO - 'PWD': '/builds/slave/test', 11:42:34 INFO - 'SHELL': '/bin/bash', 11:42:34 INFO - 'SHLVL': '1', 11:42:34 INFO - 'TERM': 'linux', 11:42:34 INFO - 'TMOUT': '86400', 11:42:34 INFO - 'USER': 'cltbld', 11:42:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:34 INFO - '_': '/tools/buildbot/bin/python'} 11:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:34 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 11:42:34 INFO - Cleaning up... 11:42:35 INFO - Return code: 0 11:42:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:42:35 INFO - Using env: {'DISPLAY': ':0', 11:42:35 INFO - 'HOME': '/home/cltbld', 11:42:35 INFO - 'LANG': 'en_US.UTF-8', 11:42:35 INFO - 'LANGUAGE': 'en_US:en', 11:42:35 INFO - 'LOGNAME': 'cltbld', 11:42:35 INFO - 'MAIL': '/var/mail/cltbld', 11:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:35 INFO - 'MOZ_NO_REMOTE': '1', 11:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:35 INFO - 'NO_EM_RESTART': '1', 11:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:35 INFO - 'PWD': '/builds/slave/test', 11:42:35 INFO - 'SHELL': '/bin/bash', 11:42:35 INFO - 'SHLVL': '1', 11:42:35 INFO - 'TERM': 'linux', 11:42:35 INFO - 'TMOUT': '86400', 11:42:35 INFO - 'USER': 'cltbld', 11:42:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:35 INFO - '_': '/tools/buildbot/bin/python'} 11:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:35 INFO - Downloading/unpacking psutil>=3.1.1 11:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:37 INFO - Installing collected packages: psutil 11:42:37 INFO - Running setup.py install for psutil 11:42:37 INFO - building 'psutil._psutil_linux' extension 11:42:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:42:37 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 11:42:37 INFO - building 'psutil._psutil_posix' extension 11:42:37 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 11:42:37 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 11:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:37 INFO - Successfully installed psutil 11:42:37 INFO - Cleaning up... 11:42:37 INFO - Return code: 0 11:42:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:42:37 INFO - Using env: {'DISPLAY': ':0', 11:42:37 INFO - 'HOME': '/home/cltbld', 11:42:37 INFO - 'LANG': 'en_US.UTF-8', 11:42:37 INFO - 'LANGUAGE': 'en_US:en', 11:42:37 INFO - 'LOGNAME': 'cltbld', 11:42:37 INFO - 'MAIL': '/var/mail/cltbld', 11:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:37 INFO - 'MOZ_NO_REMOTE': '1', 11:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:37 INFO - 'NO_EM_RESTART': '1', 11:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:37 INFO - 'PWD': '/builds/slave/test', 11:42:37 INFO - 'SHELL': '/bin/bash', 11:42:37 INFO - 'SHLVL': '1', 11:42:37 INFO - 'TERM': 'linux', 11:42:37 INFO - 'TMOUT': '86400', 11:42:37 INFO - 'USER': 'cltbld', 11:42:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:37 INFO - '_': '/tools/buildbot/bin/python'} 11:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:42:40 INFO - Installing collected packages: mozsystemmonitor 11:42:40 INFO - Running setup.py install for mozsystemmonitor 11:42:40 INFO - Successfully installed mozsystemmonitor 11:42:40 INFO - Cleaning up... 11:42:40 INFO - Return code: 0 11:42:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:42:40 INFO - Using env: {'DISPLAY': ':0', 11:42:40 INFO - 'HOME': '/home/cltbld', 11:42:40 INFO - 'LANG': 'en_US.UTF-8', 11:42:40 INFO - 'LANGUAGE': 'en_US:en', 11:42:40 INFO - 'LOGNAME': 'cltbld', 11:42:40 INFO - 'MAIL': '/var/mail/cltbld', 11:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:40 INFO - 'MOZ_NO_REMOTE': '1', 11:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:40 INFO - 'NO_EM_RESTART': '1', 11:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:40 INFO - 'PWD': '/builds/slave/test', 11:42:40 INFO - 'SHELL': '/bin/bash', 11:42:40 INFO - 'SHLVL': '1', 11:42:40 INFO - 'TERM': 'linux', 11:42:40 INFO - 'TMOUT': '86400', 11:42:40 INFO - 'USER': 'cltbld', 11:42:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:40 INFO - '_': '/tools/buildbot/bin/python'} 11:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:42 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:42 INFO - warning: no files found matching '*.txt' 11:42:42 INFO - no previously-included directories found matching 'build' 11:42:42 INFO - no previously-included directories found matching 'dist' 11:42:42 INFO - no previously-included directories found matching '.git*' 11:42:42 INFO - Installing collected packages: jsonschema, functools32 11:42:42 INFO - Running setup.py install for functools32 11:42:42 INFO - warning: no files found matching '*.txt' 11:42:42 INFO - no previously-included directories found matching 'build' 11:42:42 INFO - no previously-included directories found matching 'dist' 11:42:42 INFO - no previously-included directories found matching '.git*' 11:42:42 INFO - Successfully installed jsonschema functools32 11:42:42 INFO - Cleaning up... 11:42:42 INFO - Return code: 0 11:42:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:42:42 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')]} 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 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')]} 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 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 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:42 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 11:42:42 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 11:42:42 INFO - Using env: {'DISPLAY': ':0', 11:42:42 INFO - 'HOME': '/home/cltbld', 11:42:42 INFO - 'LANG': 'en_US.UTF-8', 11:42:42 INFO - 'LANGUAGE': 'en_US:en', 11:42:42 INFO - 'LOGNAME': 'cltbld', 11:42:42 INFO - 'MAIL': '/var/mail/cltbld', 11:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:42 INFO - 'MOZ_NO_REMOTE': '1', 11:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:42 INFO - 'NO_EM_RESTART': '1', 11:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:42 INFO - 'PWD': '/builds/slave/test', 11:42:42 INFO - 'SHELL': '/bin/bash', 11:42:42 INFO - 'SHLVL': '1', 11:42:42 INFO - 'TERM': 'linux', 11:42:42 INFO - 'TMOUT': '86400', 11:42:42 INFO - 'USER': 'cltbld', 11:42:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:42 INFO - '_': '/tools/buildbot/bin/python'} 11:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:42:42 INFO - Cleaning up... 11:42:42 INFO - Return code: 0 11:42:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:42 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')]} 11:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:42 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')]} 11:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:42:43 INFO - Using env: {'DISPLAY': ':0', 11:42:43 INFO - 'HOME': '/home/cltbld', 11:42:43 INFO - 'LANG': 'en_US.UTF-8', 11:42:43 INFO - 'LANGUAGE': 'en_US:en', 11:42:43 INFO - 'LOGNAME': 'cltbld', 11:42:43 INFO - 'MAIL': '/var/mail/cltbld', 11:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:43 INFO - 'MOZ_NO_REMOTE': '1', 11:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:43 INFO - 'NO_EM_RESTART': '1', 11:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:43 INFO - 'PWD': '/builds/slave/test', 11:42:43 INFO - 'SHELL': '/bin/bash', 11:42:43 INFO - 'SHLVL': '1', 11:42:43 INFO - 'TERM': 'linux', 11:42:43 INFO - 'TMOUT': '86400', 11:42:43 INFO - 'USER': 'cltbld', 11:42:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:43 INFO - '_': '/tools/buildbot/bin/python'} 11:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:45 INFO - Downloading docopt-0.6.1.tar.gz 11:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:45 INFO - Running setup.py install for blobuploader 11:42:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:46 INFO - Running setup.py install for requests 11:42:46 INFO - Running setup.py install for docopt 11:42:46 INFO - Successfully installed blobuploader requests docopt 11:42:46 INFO - Cleaning up... 11:42:46 INFO - Return code: 0 11:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:46 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')]} 11:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:46 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')]} 11:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:46 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 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:46 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 11:42:46 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 11:42:46 INFO - Using env: {'DISPLAY': ':0', 11:42:46 INFO - 'HOME': '/home/cltbld', 11:42:46 INFO - 'LANG': 'en_US.UTF-8', 11:42:46 INFO - 'LANGUAGE': 'en_US:en', 11:42:46 INFO - 'LOGNAME': 'cltbld', 11:42:46 INFO - 'MAIL': '/var/mail/cltbld', 11:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:46 INFO - 'MOZ_NO_REMOTE': '1', 11:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:46 INFO - 'NO_EM_RESTART': '1', 11:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:46 INFO - 'PWD': '/builds/slave/test', 11:42:46 INFO - 'SHELL': '/bin/bash', 11:42:46 INFO - 'SHLVL': '1', 11:42:46 INFO - 'TERM': 'linux', 11:42:46 INFO - 'TMOUT': '86400', 11:42:46 INFO - 'USER': 'cltbld', 11:42:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:46 INFO - '_': '/tools/buildbot/bin/python'} 11:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:46 INFO - Running setup.py (path:/tmp/pip-q1PLU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:46 INFO - Running setup.py (path:/tmp/pip-0ciYzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:46 INFO - Running setup.py (path:/tmp/pip-0RzoQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:46 INFO - Running setup.py (path:/tmp/pip-KNB8Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:47 INFO - Running setup.py (path:/tmp/pip-LCSkKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:47 INFO - Running setup.py (path:/tmp/pip-iDImA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:47 INFO - Running setup.py (path:/tmp/pip-Meb7dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:47 INFO - Running setup.py (path:/tmp/pip-CJrsnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:47 INFO - Running setup.py (path:/tmp/pip-6y8jYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:47 INFO - Running setup.py (path:/tmp/pip-fY2Cds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:47 INFO - Running setup.py (path:/tmp/pip-ev8VS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:47 INFO - Running setup.py (path:/tmp/pip-_hIPlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:47 INFO - Running setup.py (path:/tmp/pip-raRC9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:47 INFO - Running setup.py (path:/tmp/pip-hLeUu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:47 INFO - Running setup.py (path:/tmp/pip-uPgKA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:47 INFO - Running setup.py (path:/tmp/pip-tjO2W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:47 INFO - Running setup.py (path:/tmp/pip-rqtg3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:47 INFO - Running setup.py install for manifestparser 11:42:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Running setup.py install for mozcrash 11:42:48 INFO - Running setup.py install for mozdebug 11:42:48 INFO - Running setup.py install for mozdevice 11:42:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Running setup.py install for mozfile 11:42:48 INFO - Running setup.py install for mozhttpd 11:42:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Running setup.py install for mozinfo 11:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Running setup.py install for mozInstall 11:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Running setup.py install for mozleak 11:42:48 INFO - Running setup.py install for mozlog 11:42:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:48 INFO - Running setup.py install for moznetwork 11:42:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Running setup.py install for mozprocess 11:42:49 INFO - Running setup.py install for mozprofile 11:42:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Running setup.py install for mozrunner 11:42:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Running setup.py install for mozscreenshot 11:42:49 INFO - Running setup.py install for moztest 11:42:49 INFO - Running setup.py install for mozversion 11:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:49 INFO - Cleaning up... 11:42:49 INFO - Return code: 0 11:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:49 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 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:49 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 11:42:49 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 11:42:49 INFO - Using env: {'DISPLAY': ':0', 11:42:49 INFO - 'HOME': '/home/cltbld', 11:42:49 INFO - 'LANG': 'en_US.UTF-8', 11:42:49 INFO - 'LANGUAGE': 'en_US:en', 11:42:49 INFO - 'LOGNAME': 'cltbld', 11:42:49 INFO - 'MAIL': '/var/mail/cltbld', 11:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:49 INFO - 'MOZ_NO_REMOTE': '1', 11:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:49 INFO - 'NO_EM_RESTART': '1', 11:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:49 INFO - 'PWD': '/builds/slave/test', 11:42:49 INFO - 'SHELL': '/bin/bash', 11:42:49 INFO - 'SHLVL': '1', 11:42:49 INFO - 'TERM': 'linux', 11:42:49 INFO - 'TMOUT': '86400', 11:42:49 INFO - 'USER': 'cltbld', 11:42:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:49 INFO - '_': '/tools/buildbot/bin/python'} 11:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:49 INFO - Running setup.py (path:/tmp/pip-WB2de8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:50 INFO - Running setup.py (path:/tmp/pip-Cy2tQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:50 INFO - Running setup.py (path:/tmp/pip-0BZUBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:50 INFO - Running setup.py (path:/tmp/pip-cXW0ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:50 INFO - Running setup.py (path:/tmp/pip-YZVcq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:50 INFO - Running setup.py (path:/tmp/pip-N30KzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:50 INFO - Running setup.py (path:/tmp/pip-7ViPXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:50 INFO - Running setup.py (path:/tmp/pip-4AcwxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:50 INFO - Running setup.py (path:/tmp/pip-qC9xSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:50 INFO - Running setup.py (path:/tmp/pip-rBDmWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:50 INFO - Running setup.py (path:/tmp/pip-cIzrzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:50 INFO - Running setup.py (path:/tmp/pip-_4Dt8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:50 INFO - Running setup.py (path:/tmp/pip-_Qvsht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:50 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)) 11:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:50 INFO - Running setup.py (path:/tmp/pip-9F3Dzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:51 INFO - Running setup.py (path:/tmp/pip-fyeeSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:51 INFO - Running setup.py (path:/tmp/pip-XRKbwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:51 INFO - Running setup.py (path:/tmp/pip-Nq7VFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:53 INFO - Downloading blessings-1.6.tar.gz 11:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:53 INFO - Installing collected packages: blessings 11:42:53 INFO - Running setup.py install for blessings 11:42:53 INFO - Successfully installed blessings 11:42:53 INFO - Cleaning up... 11:42:53 INFO - Return code: 0 11:42:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:53 INFO - Reading from file tmpfile_stdout 11:42:53 INFO - Current package versions: 11:42:53 INFO - argparse == 1.2.1 11:42:53 INFO - blessings == 1.6 11:42:53 INFO - blobuploader == 1.2.4 11:42:53 INFO - docopt == 0.6.1 11:42:53 INFO - functools32 == 3.2.3-2 11:42:53 INFO - jsonschema == 2.5.1 11:42:53 INFO - manifestparser == 1.1 11:42:53 INFO - mozInstall == 1.12 11:42:53 INFO - mozcrash == 0.17 11:42:53 INFO - mozdebug == 0.1 11:42:53 INFO - mozdevice == 0.48 11:42:53 INFO - mozfile == 1.2 11:42:53 INFO - mozhttpd == 0.7 11:42:53 INFO - mozinfo == 0.9 11:42:53 INFO - mozleak == 0.1 11:42:53 INFO - mozlog == 3.4 11:42:53 INFO - moznetwork == 0.27 11:42:53 INFO - mozprocess == 0.23 11:42:53 INFO - mozprofile == 0.28 11:42:53 INFO - mozrunner == 6.12 11:42:53 INFO - mozscreenshot == 0.1 11:42:53 INFO - mozsystemmonitor == 0.3 11:42:53 INFO - moztest == 0.7 11:42:53 INFO - mozversion == 1.4 11:42:53 INFO - psutil == 3.1.1 11:42:53 INFO - requests == 1.2.3 11:42:53 INFO - wsgiref == 0.1.2 11:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:53 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')]} 11:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:53 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')]} 11:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:53 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 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:53 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 11:42:53 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 11:42:53 INFO - Using env: {'DISPLAY': ':0', 11:42:53 INFO - 'HOME': '/home/cltbld', 11:42:53 INFO - 'LANG': 'en_US.UTF-8', 11:42:53 INFO - 'LANGUAGE': 'en_US:en', 11:42:53 INFO - 'LOGNAME': 'cltbld', 11:42:53 INFO - 'MAIL': '/var/mail/cltbld', 11:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:53 INFO - 'MOZ_NO_REMOTE': '1', 11:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:53 INFO - 'NO_EM_RESTART': '1', 11:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:53 INFO - 'PWD': '/builds/slave/test', 11:42:53 INFO - 'SHELL': '/bin/bash', 11:42:53 INFO - 'SHLVL': '1', 11:42:53 INFO - 'TERM': 'linux', 11:42:53 INFO - 'TMOUT': '86400', 11:42:53 INFO - 'USER': 'cltbld', 11:42:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:53 INFO - '_': '/tools/buildbot/bin/python'} 11:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 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)) 11:42:53 INFO - Cleaning up... 11:42:53 INFO - Return code: 0 11:42:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:53 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')]} 11:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:53 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')]} 11:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:53 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 0x7f49c8520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, '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': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', '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 11:42:53 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 11:42:53 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 11:42:53 INFO - Using env: {'DISPLAY': ':0', 11:42:53 INFO - 'HOME': '/home/cltbld', 11:42:53 INFO - 'LANG': 'en_US.UTF-8', 11:42:53 INFO - 'LANGUAGE': 'en_US:en', 11:42:53 INFO - 'LOGNAME': 'cltbld', 11:42:53 INFO - 'MAIL': '/var/mail/cltbld', 11:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:53 INFO - 'MOZ_NO_REMOTE': '1', 11:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:53 INFO - 'NO_EM_RESTART': '1', 11:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:53 INFO - 'PWD': '/builds/slave/test', 11:42:53 INFO - 'SHELL': '/bin/bash', 11:42:53 INFO - 'SHLVL': '1', 11:42:53 INFO - 'TERM': 'linux', 11:42:53 INFO - 'TMOUT': '86400', 11:42:53 INFO - 'USER': 'cltbld', 11:42:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:53 INFO - '_': '/tools/buildbot/bin/python'} 11:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:42:54 INFO - Cleaning up... 11:42:54 INFO - Return code: 0 11:42:54 INFO - Running post-action listener: _resource_record_post_action 11:42:54 INFO - Running post-action listener: _start_resource_monitoring 11:42:54 INFO - Starting resource monitoring. 11:42:54 INFO - [mozharness: 2016-10-23 18:42:54.114249Z] Finished create-virtualenv step (success) 11:42:54 INFO - [mozharness: 2016-10-23 18:42:54.114719Z] Running install step. 11:42:54 INFO - Running pre-action listener: _resource_record_pre_action 11:42:54 INFO - Running main action method: install 11:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:54 INFO - Reading from file tmpfile_stdout 11:42:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:54 INFO - Reading from file tmpfile_stdout 11:42:54 INFO - Output received: 11:42:54 INFO - Usage: mozinstall [options] installer 11:42:54 INFO - Options: 11:42:54 INFO - -h, --help show this help message and exit 11:42:54 INFO - -d DEST, --destination=DEST 11:42:54 INFO - Directory to install application into. [default: 11:42:54 INFO - "/builds/slave/test"] 11:42:54 INFO - --app=APP Application being installed. [default: firefox] 11:42:54 INFO - mkdir: /builds/slave/test/build/application 11:42:54 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'] 11:42:54 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 11:43:11 INFO - Reading from file tmpfile_stdout 11:43:11 INFO - Output received: 11:43:11 INFO - /builds/slave/test/build/application/firefox/firefox 11:43:11 INFO - Running post-action listener: _resource_record_post_action 11:43:11 INFO - [mozharness: 2016-10-23 18:43:11.098059Z] Finished install step (success) 11:43:11 INFO - [mozharness: 2016-10-23 18:43:11.098301Z] Running run-tests step. 11:43:11 INFO - Running pre-action listener: _resource_record_pre_action 11:43:11 INFO - Running main action method: run_tests 11:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:11 INFO - Python 2.7.3 11:43:11 INFO - Return code: 0 11:43:11 INFO - grabbing minidump binary from tooltool 11:43:11 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')]} 11:43:11 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 0x17ccf60>, '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 0x17cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ce1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:11 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 11:43:11 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 11:43:11 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 11:43:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:11 INFO - Return code: 0 11:43:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:43:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:43:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:43:11 INFO - Using env: {'DISPLAY': ':0', 11:43:11 INFO - 'HOME': '/home/cltbld', 11:43:11 INFO - 'LANG': 'en_US.UTF-8', 11:43:11 INFO - 'LANGUAGE': 'en_US:en', 11:43:11 INFO - 'LOGNAME': 'cltbld', 11:43:11 INFO - 'MAIL': '/var/mail/cltbld', 11:43:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:11 INFO - 'MOZ_NO_REMOTE': '1', 11:43:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:11 INFO - 'NO_EM_RESTART': '1', 11:43:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:11 INFO - 'PWD': '/builds/slave/test', 11:43:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:11 INFO - 'SHELL': '/bin/bash', 11:43:11 INFO - 'SHLVL': '1', 11:43:11 INFO - 'TERM': 'linux', 11:43:11 INFO - 'TMOUT': '86400', 11:43:11 INFO - 'USER': 'cltbld', 11:43:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936', 11:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:11 INFO - '_': '/tools/buildbot/bin/python'} 11:43:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:43:11 INFO - mozversion application_buildid: 20161023101823 11:43:11 INFO - mozversion application_changeset: a9a41b69f3f9be494ae0653601c08aa388d9afe4 11:43:11 INFO - mozversion application_display_name: Nightly 11:43:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:11 INFO - mozversion application_name: Firefox 11:43:11 INFO - mozversion application_remotingname: firefox 11:43:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:43:11 INFO - mozversion application_vendor: Mozilla 11:43:11 INFO - mozversion application_version: 52.0a1 11:43:11 INFO - mozversion platform_buildid: 20161023101823 11:43:11 INFO - mozversion platform_changeset: a9a41b69f3f9be494ae0653601c08aa388d9afe4 11:43:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:43:11 INFO - mozversion platform_version: 52.0a1 11:43:11 INFO - using testdate: 1477248191 11:43:11 INFO - actual date: 1477248191 11:43:11 INFO - starting webserver on 'localhost:45233' 11:43:11 INFO - SUITE-START | Running 2 tests 11:43:11 INFO - TEST-START | dromaeo_css 11:43:11 INFO - operating with platform_type : linux_ 11:43:11 INFO - Initialising browser for dromaeo_css test... 11:43:11 INFO - TEST-INFO | started process 23781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAho2FG/profile http://localhost:45233/getInfo.html) 11:43:16 INFO - PROCESS | 23781 | __metrics Screen width/height:1600/1200 11:43:16 INFO - PROCESS | 23781 | colorDepth:24 11:43:16 INFO - PROCESS | 23781 | Browser inner width/height: 1024/697 11:43:16 INFO - PROCESS | 23781 | __metrics 11:43:16 ERROR - PROCESS | 23781 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 11:43:17 INFO - TEST-INFO | 23781: exit 0 11:43:17 INFO - Browser initialized. 11:43:17 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:17 INFO - TEST-INFO | started process 23905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAho2FG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:30 INFO - PROCESS | 23905 | RSS: Main: 183693312 11:43:30 INFO - PROCESS | 23905 | 11:44:19 INFO - PROCESS | 23905 | 1477248259752 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] 11:46:34 INFO - PROCESS | 23905 | Cycle 1(1): loaded http://localhost:45233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45233/tests/dromaeo/cssquery-ext.html) 11:46:35 INFO - PROCESS | 23905 | RSS: Main: 194056192 11:46:35 INFO - PROCESS | 23905 | 11:49:38 INFO - PROCESS | 23905 | Cycle 1(1): loaded http://localhost:45233/tests/dromaeo/cssquery-ext.html (next: http://localhost:45233/tests/dromaeo/cssquery-jquery.html) 11:49:38 INFO - PROCESS | 23905 | RSS: Main: 193982464 11:49:38 INFO - PROCESS | 23905 | 11:52:41 INFO - PROCESS | 23905 | Cycle 1(1): loaded http://localhost:45233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45233/tests/dromaeo/cssquery-mootools.html) 11:52:41 INFO - PROCESS | 23905 | RSS: Main: 196874240 11:52:41 INFO - PROCESS | 23905 | 11:55:43 INFO - PROCESS | 23905 | Cycle 1(1): loaded http://localhost:45233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45233/tests/dromaeo/cssquery-prototype.html) 11:55:44 INFO - PROCESS | 23905 | RSS: Main: 193241088 11:55:44 INFO - PROCESS | 23905 | 11:58:47 INFO - PROCESS | 23905 | Cycle 1(1): loaded http://localhost:45233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45233/tests/dromaeo/cssquery-yui.html) 11:58:47 INFO - PROCESS | 23905 | RSS: Main: 196509696 11:58:47 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | Cycle 1(1): loaded http://localhost:45233/tests/dromaeo/cssquery-yui.html (next: http://localhost:45233/tests/dromaeo/cssquery-dojo.html) 12:01:50 INFO - PROCESS | 23905 | RSS: Main: 196395008 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | __start_tp_report 12:01:50 INFO - PROCESS | 23905 | _x_x_mozilla_page_load 12:01:50 INFO - PROCESS | 23905 | _x_x_mozilla_page_load_details 12:01:50 INFO - PROCESS | 23905 | |i|pagename|runs| 12:01:50 INFO - PROCESS | 23905 | |0;dojo.html;2612.0988259050623;2629.8553579553122;2635.196265139132;2655.920322390328;2656.9070082547105;4707.90584188316;4776.761161941907;4821.710697358157;4823.758812059392;4847.733374664392;4737.170995075865;4782.617390608761;4799.5680388765;4853.199222128344;4860.4896485869;4362.694611377205;4392.428984232045;4454.910901781963;4485.686001979862;4555.453345598533;4417.42573465449;4483.394741709876;4518.8418405355815;4550.817967281305;4569.4516658001085;4327.1345730853955;4343.2182207202695;4344.196323680129;4483.641308695296;4527.728336299832;4386.846460373904;4399.428074350314;4409.250427427345;4471.910561788779;4477.6417886569;4372.27857403528;4375.6937014409;4405.9118817623785;4424.424824772791;4425.004374015853;4658.208104622222;4671.205894997858;4760.285957106462;4780;4783.3064205690325;5107.20838270065;5200.947990520084;5204.115300398941;5206.713630750307;5262.973685131588;5229.790808367698;5232.319798426218;5239.528442440161;5242.842714718565;5295.947040529584;4742.170120228946;4844.370231869834;4848.151573474628;4850.078485087822;4851.563359297609;5222.190560463135;5258.158694608845;5274.156135018456;5285.788568457296;5294.258803767476;5007.098722230034;5043.445221025684;5072.771725272371;5076.390833100052;5085.796568137233;5165.276861239429;5169.121249387613;5179.119549676564;5216.765245563959;5237.423883372826;5143.8456846294675;5166.819161329336;5173.5602473789395;5174.24973378858;5188.507091826271;5150.330457040561;5158.123119069767;5159.458256883048;5161.458046905096;5209.453007434241;4252.55348188442;4296.054867929113;4306.913861722748;4352.129574085196;4359.062801497693;3779.225258821935;3783.129880127586;3786.3752480840353;3826.9808650956566;3839.577646458887;4507.526709695435;4512.684112112121;4513.390692256569;4517.954820451819;4556.3165525170825;5059.06407314648;5063.1645778446145;5119.155339368963;5143.8456846294675;5200.713960732196;4470.485894122153;4476.731396116244;4506.639468842484;4510.661700372485;4531.229690952546;4605.217113090783;4608.331791890158;4610.377599024089;4617.953820461819;4664.836730714409;4709.105269998689;4767.141914455431;4818.566329030404;4835.057163853015;4841.878953026203;5161.225816127611;5206.97396513015;5209.453007434165;5258.1849813279005;5269.736513174403;4762.809487620457;4854.83008094715;4855.1260773061185;4861.927071093865;4923.433805112458;5057.924131137962;5069.138246498178;5140.30605868203;5143.279940808365;5161.638685291993;5012.548870601663;5020.121478741133;5076.162433198629;5215.739213039409;5235;5050.3182070420025;5089.5419412251595;5109.948900510947;5113.693178409308;5127.4872512748425;4981.153203955409;5017.67385119966;5051.040302342543;5056.721880296619;5057.924131138109;4951.678140920829;4962.801487940442;4988.700677959189;4998.725070121178;5055.443901170942;4935.111679897653;4996.400431948189;5052.5705315048635;5099.6175286852895;5104.770285337243;4964.081644895706;4998.6750861193905;5003.374578177728;5003.599712023102;5043.344365232643 12:01:50 INFO - PROCESS | 23905 | |1;ext.html;540.502737481517;541.2152379050378;544.0316237097966;552.6794459213655;556.7299859568109;37700.434493482586;39173.41239881404;39206.21587568247;42573.574264257346;42683.573164268346;40060.19879602406;40255.396169057414;40261.19477610446;40284.59715402845;40395.79802100993;7622.161562228164;7751.984484034164;7754.379649628045;7757.961210193941;7764.611769411535;7529.397648188159;7576.318131368176;7667.42494312926;7668.654910529011;7670.769876903674;7600.923990760105;7670.27132422419;7689.192634773352;7740.303372696456;7746.961265193666;7685.769426917173;7704.345130663873;7717.151113377524;7717.3054425101445;7717.65270562826;7693.9615301923695;7751.457397982143;7757.922420775776;7761.7671469855995;7762.262585054411;37672.811635941645;37981.43027854584;38132.42801357954;38145;38183.427248591295;2975.4197931403387;2989.5814585957983;3016.547517872315;3229.7416206703642;3276.475763877792;27706.584401234;27888.16335509938;28273.15180544587;28431.857840710873;28467.288317792012;3467.9653203467897;3475.7566970312087;3518.8064656443885;3534.8232588370734;3543.557055368079;228618;229009;229373;229504;229867;49602;49799.502004979484;49870;49872.750636247314;50016.24975625369;52544.737276313375;52723;52791.73604131955;52836.73581632067;53134.46865531372;13044.41300141496;13190.802137967938;13216.140950838164;13279.336033198302;13322.267275299952;10195.490225488697;10204.591816327413;10222.386656800616;10259;10314.43270620123;14364.35360408784;15794.447194348142;15870.52388428349;15923.203839807964;15985.44050958211;5959.4934430573885;6005.279366475964;6006.699665016732;6060.908637044433;6152.723127459186;732.7508647060025;824.5228409735076;881.1056777370974;882.6866462405882;958.8609651600478;25771;27932;28126.29684257869;28197.295067623472;28278.15165545037;924.9722508324761;959.203860795538;1019.3628981886321;1029.3669393323053;1031.9535620897077;13744.725105497833;14551.927240363942;14569.708605827824;14589.416423342947;14819.110853348619;341467;342313;348109;349222;349337;49001.75499122553;49267.26099108516;49304.50695493071;49353.75323123361;49355.50644493581;1176.353005846781;1198.406788639629;1208.5347141350644;1215.5077193736552;1216.0575553945587;24944.37639059038;25134.874325628254;25867.741322586535;26125.477490450463;26263;42081.36877946772;43120;43168;43193;43264.78367608142;312206;312961;313881;314109;314948;23560.29319120429;24027.159049433187;24094.470080641982;24249.63625545583;24528.264152075466;39845.40231896582;40072;40707;41558.79220603878;42116.36825447682;35209;35338.82330588331;35494.46758298679;35845;36956.44565331468;34862.47706284357;34948.825255873555;35348.823255884585;35598.64401355953;36354.63645363618;33827.66172338245;34301.828490857384;34547.48178777371;34828.825855871575;34904.47643285403;31163.688363116984;32373.67626323801;32782.88562586551;32822.34355312928;32880.50679239765;24492;24934;24935;25022.74977250277;25227.74772252254 12:01:50 INFO - PROCESS | 23905 | |2;jquery.html;354.50900502803626;364.89600463867805;366.10669965284706;373.058028478093;387.1733848234021;15445.768313475306;15694;16874.156292185387;17051.91474042628;17125.14374281287;16348.346066157339;16647.25087371068;16704.331826726917;16823.327066917307;16913.83086169138;4755.120302743986;5099.031184075033;5104.795808167669;5108.131617624994;5112.846614601568;4854.320395144682;4985.102681517325;5010.398752149747;5062.367204099488;5078.1874900016;4998.650094493387;5001.574866136383;5009.298698182258;5011.824586139486;5035.446100928895;4858.902821943577;4997.575206107485;4998.775055122528;5005.074061298653;5019.196928491424;4446.955530444687;4494.8876278092985;4498.640108791322;4500.909981800346;4513.7517436540975;19443.805561944482;19929.9003504983;19970.800291997184;20328.89835550813;20520.897395513075;1776.5558610347414;1842.5485755989735;1855.9350422735274;1869.5045812859603;1982.9405117846488;8918.73243802687;8935.687250946186;9006.954965225197;9185;9310.534473276377;1657.801063872331;1670.181611010596;1681.3778901806288;1690.6365131496664;1772.1759381887484;57742.7112864433;60008.39991600115;60025.699871500365;61333.693331533505;67364;9256.352055356061;9498.762530936643;9591.568379422943;9820.116189542832;9957.502124893726;13385.996050296268;13398.196108233537;13400.664983375298;13404.463821447032;13408.128471649312;6662.167229096363;6835.179778426621;6970.093887794555;7095.764834077249;7157.57054576727;6237.376262373817;6462.612243265419;6723;6757.087793147961;6867.553609015398;4170.395292682605;4229.048464095554;4268.317069268902;4270.338097594816;4330.480342358937;1754.1141723429587;1771.1852547828144;1786.9553261168314;1831.5878927241265;1907.4182374375948;798.4131663227523;839.2195258409615;867.5618812499773;938.4510061613896;942.5004747483845;15875.52373428799;16512.587185320463;16904.239309231114;17252.309907603554;17275.222614982355;807.7495976247382;843.9282660973763;865.3164000439708;883.8718385834018;924.9445033298024;9035.277177825757;9228.5847136879;9559.952200238955;9627.374220675634;9629.807403851884;336124;338161;340187;343572;351879;44594.55405445969;44609.55390446054;57815.13277300844;73103.63448182725;75762.62118689482;869.4783130121876;881.8104107616894;894.5706061090583;895.5925054100369;915.1443400420628;15430.22848857575;15552.30014649321;15817.841821582097;15836.208189590705;15849;34767;36963.44554831734;37093;37591;37847.61971415547;49369.50630493649;49509.50490495049;49738.75130624323;50001.74999124981;50297.49702502928;6318.526110541819;7221.638918053971;7300.96349518249;7340.889886651811;7624;8188.7952801180445;10526.473676316307;10630.415327156772;10703.839442408525;11314.20800543987;8482.140626015273;8838.867416988622;9001.36990410665;9057.275417966679;9546.665866694633;8533.74398768038;9563;9849.359791613522;9887.406755594688;9989.200863930722;9445.905540944503;9496.14534691881;9500.907395649312;9616.75958101053;10157.593696252363;6145.784897528565;7416.25837416254;7418.703251870081;7478.214787447239;7601.505902116345;9147.359684821999;9162.221211197122;9207.631694732136;9221.861672075058;9716.976456009914 12:01:50 INFO - PROCESS | 23905 | |3;mootools.html;1368.657835541115;1399.398258748738;1503.5789978805938;1690.9577260568492;1704.4204970310093;6556.803295901131;6802.863942721143;7379.2620737926245;7959.243871832174;8051.677932882685;7526.172121066678;7881.842363152748;7885.211478852112;7899.4075444341615;7905.604719764017;2104.5054412213117;2137.1237792505076;2137.187868609926;2137.348108826807;2140.646793279107;2067.948301292472;2099.6850472429182;2169.240765731989;2179.3353027326657;2179.69484272202;2125.0968338456173;2143.8606490578063;2154.5367745934623;2166.869987800729;2183.8471307008517;2094.937151885446;2107.2413930984835;2107.7365329333834;2108.8312934965243;2110.177030957928;2041.2855500574829;2062.175129948018;2082.344061620585;2082.875027498355;2083.906224219914;7768.067831860157;7855.096663883669;7895.092064412609;7925.2960613468385;7925.762227133196;4462.910741785178;4566.246569316058;4573.336866154389;4605.217113090783;4608.815647374101;2774.5005898938184;2813.4091840713477;2834.6393731009025;2862.5992361069466;2870.2967772895568;884.2263019857625;904.3940559824933;918.5728636184207;928.1136514628514;1737.8001529824105;10457.895421045845;10515.106215971651;10596.152307815357;10631.574737010511;10662.040416362486;3733.9626603733614;4002.4396584478195;4007.358822588372;4106.630403263721;4114.156597897424;8362.414630975773;8364;8367;8374.623141958626;8376.288015518627;4494.685372023992;4528.139653465831;4535.160995215896;4537.910901383711;4538.047010127844;3547;3650.178709790329;3977.3039718049226;4178.979105104455;4208.137331846964;3236.4983427568764;3301.9339613207603;3409.147713071732;3437.5874895012757;3453.671901169385;980.7253968888723;1002.4386343647581;1004;1006.8320747932363;1012.4836333469983;801.4790386248985;829.3158144530786;832.8625776746769;833.6290350793838;835.3317346123077;4968.527989840959;5141.151709967813;5209.817656382009;5268.789248430096;5333.120035194227;414.1861242658131;419.3248869320392;430.05602702069285;430.2749866475;435.7799311347749;3373.8819141330428;3509.385857474983;3509.719222462248;3672.1554042569824;3674.0447483654443;9097.13577210164;9349.626014959462;9500.714978550655;9601.039896010343;9617.903820961841;9565.04349565038;9565.139137477521;9571.28215383849;9571.712848614414;9579.13787759105;7230;7294.270572942663;7324.926750732425;7327.230640782747;7335.926640733631;4921.803127874845;4941.184704523857;4953.678010929278;4966.726830024383;5354.7858085676135;8614.396992210484;8635.611397487253;8721.215090641872;8735.956320218358;8811.779705507413;8704.173103555153;8909.821803563762;8919.331050171133;8979.371443998858;9029.006809250846;6217.720202590804;6242.875142497034;6248.500119990299;6290.968545157428;6330.303666596578;7309.634518273959;7355.374793142642;7360;7365.558066516026;7398.630068496661;6426.035680226152;6635;6724.899126513008;6742.224644165984;6885.862282754417;6436.581622194542;6726.730930762715;6794.3545363190415;6858.554193977376;6900.171979362509;5949.167116603766;6054.061620448838;6113.449789518964;6150.10823430609;6174.783882564088;4425.269830477935;4500.234960056864;4522.4573051234065;4575.679702420799;4628;4249.6387807036745;4376.277914144258;4384.210842048462;4485.775711214361;4491.7754112293605 12:01:50 INFO - PROCESS | 23905 | |4;prototype.html;287.5858763380732;291.21953165516413;297.0494417862838;311.3819069147741;316.7070459824662;5027.547520723134;5049.671771334861;5059.6964182149095;5090.8472745817635;5093.134167191577;4941.530554597316;4973.72644504553;4992.600591952644;5003.47463516331;5018.974905125469;3975.6223158799867;3998.9600103999023;4002.9199416011734;4005.259027079985;4006.61937115975;3847.615238476158;3914.9804250978705;3922.5096862892137;3982.800859957005;4012.4752594014235;3886.650201481866;3899.6880249579967;3904.6681032112306;3905.1799122184375;3924.7841368724853;3898;3900.771257054033;3920.7843568603716;3933.1150491139265;3945.6054394560315;3325.817080060596;3450.7584469087174;3454.9827250863837;3462.515247865301;3471.3057388522398;4838.177509823338;4841.903161936777;4854.660173787836;4862.200985635338;4877.658563900528;4468.128714900596;4486.506484286726;4509.436320459942;4509.526499717548;4515.277555591122;5029.974850125763;5181.911798522315;5203.089459344599;5216.739163041832;5229.294045303911;3785.2429514097016;3788.090858194041;3795.9430608540893;3805.353089974711;3812.6377994090517;5402.189671549259;5470.480304371078;5489.972550137224;5495.8351249462185;5514.6691198528215;3804.353259945816;3856.093817952779;3908.6710518423874;3913.5108111486065;3926.1166237596312;3881.5342158941107;3895.9805200973815;3902.453656488094;3910.2570511602703;3915.393114067324;4421.977890110529;4426.955730442719;4429.269170586817;4430.601245887886;4453.643708503312;5179.2749015137915;5181.637285390062;5212.374515058217;5263.921041184385;5266.552343050807;1294.6310301564008;1359.8300212473441;1370.7327071221216;1371.3475262308893;1375.9449622015206;871.6426265231224;879.4283715584921;889.7019498468086;898.8247291778172;907.8456662367413;4054.8378064877074;4056.553779084298;4058.431819545266;4064.4309796628495;4090.5091389033505;4673.579377855941;4680.438347398334;4685.554872287127;4725.228039485193;4729.62163026957;4023.4970628671417;4062.532808727034;4082.408050832613;4087.3854827343625;4146.91706165875;2485.260317777563;2664.520386330479;2868.856557172133;2870.454613623405;2882.8126171798767;4711.434627844681;4875.634327425457;4882.926756098661;5019.39379398589;5024.834354356732;5497.835064948058;5498.285222920995;5514.448555144534;5526;5560.388357280696;4832.251001094836;5041.6722913010535;5049.813293875936;5070.771815268396;5083.644144909821;5312.4156342803035;5353.22378255143;5371.248025276543;5420.349558052902;5430.212619170277;5275.920861187162;5287.576993840406;5292.179712144623;5307.708076055854;5312.442193569619;4708.976455117702;4963;5054.924176137288;5056.115179843586;5072.137736584863;3730.626937306356;3738;3749.418840079792;3755.9812200938823;3756.3050835595504;5384.865378365415;5392.946070539245;5437.32033495813;5444.210589464585;5480.150576660624;4985.581992733449;5216.608754343363;5285.68285902847;5317.574594032545;5324.653897496651;5239.240310155083;5276.525112739719;5296;5302.337207849019;5344.866378340573;5191.844244672666;5237.921431178612;5247.475252474875;5263.23683065961;5267.446918073547;4955.571769832828;5266.446398312431;5309.628326017141;5329.1206950852675;5340.092184328596;5222.791088356423;5240.606954478506;5244.711540865136;5256.737163141904;5258.737063146904 12:01:50 INFO - PROCESS | 23905 | |5;yui.html;669.4042302350907;683.5966779600035;691.3915754136361;711.8860982242842;717.9102612173479;12064.939675301623;12828.615141545744;13005.60983170504;13242.668933276673;14152.50466233682;13457.73084538311;13584.728305433886;13782.793258101137;13800.723985520284;13801.723965520683;763.2710761223019;784.2001158818002;796.1242633103569;805.7985503624094;811.2658044469764;813.3411936331561;820.335528222142;820.4666966471782;821.3962737388044;822.7120507822244;842.9789255268637;843.8860753798251;843.9324854011695;844.2865778417228;844.8056946902216;836.2306677856386;836.8870202522643;838.2078935406043;838.651959436833;841.474078700812;615.9137720719103;616.0943413182614;616.5468380740152;619.2414292491707;619.3187493756876;13438.395272212676;13455.529056482976;13481.932590337083;13505.729885402336;13507.86492135076;12727.109102362838;13039;13193.670158246025;13326.333683315892;13497.730045399136;10787.6224332148;10804.243702940797;10864.511097000654;10919.235653504258;11052.723681907935;3300.1914530940076;3303.3888730584918;3368;3382.5602671652773;3387.6442973487924;49254.50745492571;49351;49529.50470495285;62225.6888715558;62998.37001629971;9202.079792020744;9219.861702074475;9338.813223735488;9382.906170938204;9427.952860235655;18282.634347313244;18301;18381.81618183828;18408.410359979942;18409.43519800805;6253.374662533801;6416.326285740023;6429.903551446732;6454.9677251614385;6666.799996000128;3427.160345715266;3478.7390945679176;3493.9126521837156;3532.752707310515;3589.1565482111682;2956.9704302956693;3064.9540256896166;3065.0651551277074;3066.0801759472515;3083.5066389377594;477.59404506169477;486.365293292257;499.0966350904874;500.1372632209482;504.4955044955045;500.9549140577366;566.9971650141723;570.4837122404231;572.8625129968777;600.729457198023;7742.877282793963;8053.355731541463;8078.757637270891;8143.063547691972;8256.8348633027;474.0696753760846;503.4311228311984;556.6075916478873;560.80932482956;621.9409156130251;3694.2057457646197;3714.9071273217846;3714.9442758358646;3791.658750712449;3962.1481381503113;50112.24831627528;83975.580122099;85388.7191692125;93046.53476732709;93608;76415.61792191115;77159.61420192975;77605.6119719409;78016.60991695005;80148;67954.3204567948;71200.64399677969;71625.28374716185;71996.28003719896;72247.2775272251;6886.24251332343;7061.788146355618;7208.17106032792;7215.567065975848;7250;40901.59098408978;41210.38184427176;42114.789426052674;42843.357349640406;43077.35383969306;54689.71068327194;61839.381606183364;62675.37324626878;64032.399190020624;64275.35724642694;9457.19613832832;9516.143547080796;9837.114659680663;9900.108990190918;10103.040211179927;10296.485175741333;10397.33783649536;10442.68671939843;10532.368057916243;10652.520636571218;10073.345232559861;10184.134348580454;10207.84688229692;10236.53935572886;10447.223971924639;9858.802823943624;9959.05388988045;10079.770467553086;10319.122874555747;10587.735306617396;9970;9984.400935943866;10007.599696012368;10224.897751022394;10401.063904248655;8148.185181481805;8356.66573337084;8473.195046470575;8759.474431534129;8902.332325075517;8103.83792324162;8477.194666506672;9027.729168124966;9052.321075919464;9422.434653920787 12:01:50 INFO - PROCESS | 23905 | __end_tp_report 12:01:50 INFO - PROCESS | 23905 | __start_cc_report 12:01:50 INFO - PROCESS | 23905 | _x_x_mozilla_cycle_collect,336 12:01:50 INFO - PROCESS | 23905 | __end_cc_report 12:01:50 INFO - PROCESS | 23905 | __startTimestamp1477249310896__endTimestamp 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | ------- Summary: start ------- 12:01:50 INFO - PROCESS | 23905 | Number of tests: 6 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | [#0] dojo.html Cycles:165 Average:4770.37 Median:4860.49 stddev:512.90 (10.6%) stddev-sans-first:485.73 12:01:50 INFO - PROCESS | 23905 | Values: 2612.1 2629.9 2635.2 2655.9 2656.9 4707.9 4776.8 4821.7 4823.8 4847.7 4737.2 4782.6 4799.6 4853.2 4860.5 4362.7 4392.4 4454.9 4485.7 4555.5 4417.4 4483.4 4518.8 4550.8 4569.5 4327.1 4343.2 4344.2 4483.6 4527.7 4386.8 4399.4 4409.3 4471.9 4477.6 4372.3 4375.7 4405.9 4424.4 4425.0 4658.2 4671.2 4760.3 4780.0 4783.3 5107.2 5200.9 5204.1 5206.7 5263.0 5229.8 5232.3 5239.5 5242.8 5295.9 4742.2 4844.4 4848.2 4850.1 4851.6 5222.2 5258.2 5274.2 5285.8 5294.3 5007.1 5043.4 5072.8 5076.4 5085.8 5165.3 5169.1 5179.1 5216.8 5237.4 5143.8 5166.8 5173.6 5174.2 5188.5 5150.3 5158.1 5159.5 5161.5 5209.5 4252.6 4296.1 4306.9 4352.1 4359.1 3779.2 3783.1 3786.4 3827.0 3839.6 4507.5 4512.7 4513.4 4518.0 4556.3 5059.1 5063.2 5119.2 5143.8 5200.7 4470.5 4476.7 4506.6 4510.7 4531.2 4605.2 4608.3 4610.4 4618.0 4664.8 4709.1 4767.1 4818.6 4835.1 4841.9 5161.2 5207.0 5209.5 5258.2 5269.7 4762.8 4854.8 4855.1 4861.9 4923.4 5057.9 5069.1 5140.3 5143.3 5161.6 5012.5 5020.1 5076.2 5215.7 5235.0 5050.3 5089.5 5109.9 5113.7 5127.5 4981.2 5017.7 5051.0 5056.7 5057.9 4951.7 4962.8 4988.7 4998.7 5055.4 4935.1 4996.4 5052.6 5099.6 5104.8 4964.1 4998.7 5003.4 5003.6 5043.3 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | [#1] ext.html Cycles:180 Average:45001.41 Median:19441.82 stddev:78924.57 (406.0%) stddev-sans-first:79075.38 12:01:50 INFO - PROCESS | 23905 | Values: 540.5 541.2 544.0 552.7 556.7 37700.4 39173.4 39206.2 42573.6 42683.6 40060.2 40255.4 40261.2 40284.6 40395.8 7622.2 7752.0 7754.4 7758.0 7764.6 7529.4 7576.3 7667.4 7668.7 7670.8 7600.9 7670.3 7689.2 7740.3 7747.0 7685.8 7704.3 7717.2 7717.3 7717.7 7694.0 7751.5 7757.9 7761.8 7762.3 37672.8 37981.4 38132.4 38145.0 38183.4 2975.4 2989.6 3016.5 3229.7 3276.5 27706.6 27888.2 28273.2 28431.9 28467.3 3468.0 3475.8 3518.8 3534.8 3543.6 228618.0 229009.0 229373.0 229504.0 229867.0 49602.0 49799.5 49870.0 49872.8 50016.2 52544.7 52723.0 52791.7 52836.7 53134.5 13044.4 13190.8 13216.1 13279.3 13322.3 10195.5 10204.6 10222.4 10259.0 10314.4 14364.4 15794.4 15870.5 15923.2 15985.4 5959.5 6005.3 6006.7 6060.9 6152.7 732.8 824.5 881.1 882.7 958.9 25771.0 27932.0 28126.3 28197.3 28278.2 925.0 959.2 1019.4 1029.4 1032.0 13744.7 14551.9 14569.7 14589.4 14819.1 341467.0 342313.0 348109.0 349222.0 349337.0 49001.8 49267.3 49304.5 49353.8 49355.5 1176.4 1198.4 1208.5 1215.5 1216.1 24944.4 25134.9 25867.7 26125.5 26263.0 42081.4 43120.0 43168.0 43193.0 43264.8 312206.0 312961.0 313881.0 314109.0 314948.0 23560.3 24027.2 24094.5 24249.6 24528.3 39845.4 40072.0 40707.0 41558.8 42116.4 35209.0 35338.8 35494.5 35845.0 36956.4 34862.5 34948.8 35348.8 35598.6 36354.6 33827.7 34301.8 34547.5 34828.8 34904.5 31163.7 32373.7 32782.9 32822.3 32880.5 24492.0 24934.0 24935.0 25022.7 25227.7 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | [#2] jquery.html Cycles:180 Average:21918.15 Median:5009.85 stddev:56356.55 (1124.9%) stddev-sans-first:56491.38 12:01:50 INFO - PROCESS | 23905 | Values: 354.5 364.9 366.1 373.1 387.2 15445.8 15694.0 16874.2 17051.9 17125.1 16348.3 16647.3 16704.3 16823.3 16913.8 4755.1 5099.0 5104.8 5108.1 5112.8 4854.3 4985.1 5010.4 5062.4 5078.2 4998.7 5001.6 5009.3 5011.8 5035.4 4858.9 4997.6 4998.8 5005.1 5019.2 4447.0 4494.9 4498.6 4500.9 4513.8 19443.8 19929.9 19970.8 20328.9 20520.9 1776.6 1842.5 1855.9 1869.5 1982.9 8918.7 8935.7 9007.0 9185.0 9310.5 1657.8 1670.2 1681.4 1690.6 1772.2 57742.7 60008.4 60025.7 61333.7 67364.0 9256.4 9498.8 9591.6 9820.1 9957.5 13386.0 13398.2 13400.7 13404.5 13408.1 6662.2 6835.2 6970.1 7095.8 7157.6 6237.4 6462.6 6723.0 6757.1 6867.6 4170.4 4229.0 4268.3 4270.3 4330.5 1754.1 1771.2 1787.0 1831.6 1907.4 798.4 839.2 867.6 938.5 942.5 15875.5 16512.6 16904.2 17252.3 17275.2 807.7 843.9 865.3 883.9 924.9 9035.3 9228.6 9560.0 9627.4 9629.8 336124.0 338161.0 340187.0 343572.0 351879.0 44594.6 44609.6 57815.1 73103.6 75762.6 869.5 881.8 894.6 895.6 915.1 15430.2 15552.3 15817.8 15836.2 15849.0 34767.0 36963.4 37093.0 37591.0 37847.6 49369.5 49509.5 49738.8 50001.7 50297.5 6318.5 7221.6 7301.0 7340.9 7624.0 8188.8 10526.5 10630.4 10703.8 11314.2 8482.1 8838.9 9001.4 9057.3 9546.7 8533.7 9563.0 9849.4 9887.4 9989.2 9445.9 9496.1 9500.9 9616.8 10157.6 6145.8 7416.3 7418.7 7478.2 7601.5 9147.4 9162.2 9207.6 9221.9 9717.0 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | [#3] mootools.html Cycles:180 Average:5010.74 Median:4931.49 stddev:2845.78 (57.7%) stddev-sans-first:2840.60 12:01:50 INFO - PROCESS | 23905 | Values: 1368.7 1399.4 1503.6 1691.0 1704.4 6556.8 6802.9 7379.3 7959.2 8051.7 7526.2 7881.8 7885.2 7899.4 7905.6 2104.5 2137.1 2137.2 2137.3 2140.6 2067.9 2099.7 2169.2 2179.3 2179.7 2125.1 2143.9 2154.5 2166.9 2183.8 2094.9 2107.2 2107.7 2108.8 2110.2 2041.3 2062.2 2082.3 2082.9 2083.9 7768.1 7855.1 7895.1 7925.3 7925.8 4462.9 4566.2 4573.3 4605.2 4608.8 2774.5 2813.4 2834.6 2862.6 2870.3 884.2 904.4 918.6 928.1 1737.8 10457.9 10515.1 10596.2 10631.6 10662.0 3734.0 4002.4 4007.4 4106.6 4114.2 8362.4 8364.0 8367.0 8374.6 8376.3 4494.7 4528.1 4535.2 4537.9 4538.0 3547.0 3650.2 3977.3 4179.0 4208.1 3236.5 3301.9 3409.1 3437.6 3453.7 980.7 1002.4 1004.0 1006.8 1012.5 801.5 829.3 832.9 833.6 835.3 4968.5 5141.2 5209.8 5268.8 5333.1 414.2 419.3 430.1 430.3 435.8 3373.9 3509.4 3509.7 3672.2 3674.0 9097.1 9349.6 9500.7 9601.0 9617.9 9565.0 9565.1 9571.3 9571.7 9579.1 7230.0 7294.3 7324.9 7327.2 7335.9 4921.8 4941.2 4953.7 4966.7 5354.8 8614.4 8635.6 8721.2 8736.0 8811.8 8704.2 8909.8 8919.3 8979.4 9029.0 6217.7 6242.9 6248.5 6291.0 6330.3 7309.6 7355.4 7360.0 7365.6 7398.6 6426.0 6635.0 6724.9 6742.2 6885.9 6436.6 6726.7 6794.4 6858.6 6900.2 5949.2 6054.1 6113.4 6150.1 6174.8 4425.3 4500.2 4522.5 4575.7 4628.0 4249.6 4376.3 4384.2 4485.8 4491.8 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | [#4] prototype.html Cycles:180 Average:4308.82 Median:4858.43 stddev:1255.14 (25.8%) stddev-sans-first:1221.84 12:01:50 INFO - PROCESS | 23905 | Values: 287.6 291.2 297.0 311.4 316.7 5027.5 5049.7 5059.7 5090.8 5093.1 4941.5 4973.7 4992.6 5003.5 5019.0 3975.6 3999.0 4002.9 4005.3 4006.6 3847.6 3915.0 3922.5 3982.8 4012.5 3886.7 3899.7 3904.7 3905.2 3924.8 3898.0 3900.8 3920.8 3933.1 3945.6 3325.8 3450.8 3455.0 3462.5 3471.3 4838.2 4841.9 4854.7 4862.2 4877.7 4468.1 4486.5 4509.4 4509.5 4515.3 5030.0 5181.9 5203.1 5216.7 5229.3 3785.2 3788.1 3795.9 3805.4 3812.6 5402.2 5470.5 5490.0 5495.8 5514.7 3804.4 3856.1 3908.7 3913.5 3926.1 3881.5 3896.0 3902.5 3910.3 3915.4 4422.0 4427.0 4429.3 4430.6 4453.6 5179.3 5181.6 5212.4 5263.9 5266.6 1294.6 1359.8 1370.7 1371.3 1375.9 871.6 879.4 889.7 898.8 907.8 4054.8 4056.6 4058.4 4064.4 4090.5 4673.6 4680.4 4685.6 4725.2 4729.6 4023.5 4062.5 4082.4 4087.4 4146.9 2485.3 2664.5 2868.9 2870.5 2882.8 4711.4 4875.6 4882.9 5019.4 5024.8 5497.8 5498.3 5514.4 5526.0 5560.4 4832.3 5041.7 5049.8 5070.8 5083.6 5312.4 5353.2 5371.2 5420.3 5430.2 5275.9 5287.6 5292.2 5307.7 5312.4 4709.0 4963.0 5054.9 5056.1 5072.1 3730.6 3738.0 3749.4 3756.0 3756.3 5384.9 5392.9 5437.3 5444.2 5480.2 4985.6 5216.6 5285.7 5317.6 5324.7 5239.2 5276.5 5296.0 5302.3 5344.9 5191.8 5237.9 5247.5 5263.2 5267.4 4955.6 5266.4 5309.6 5329.1 5340.1 5222.8 5240.6 5244.7 5256.7 5258.7 12:01:50 INFO - PROCESS | 23905 | 12:01:50 INFO - PROCESS | 23905 | [#5] yui.html Cycles:180 Average:16384.01 Median:608.32 stddev:23051.97 (3789.4%) stddev-sans-first:23086.44 12:01:50 INFO - PROCESS | 23905 | Values: 669.4 683.6 691.4 711.9 717.9 12064.9 12828.6 13005.6 13242.7 14152.5 13457.7 13584.7 13782.8 13800.7 13801.7 763.3 784.2 796.1 805.8 811.3 813.3 820.3 820.5 821.4 822.7 843.0 843.9 843.9 844.3 844.8 836.2 836.9 838.2 838.7 841.5 615.9 616.1 616.5 619.2 619.3 13438.4 13455.5 13481.9 13505.7 13507.9 12727.1 13039.0 13193.7 13326.3 13497.7 10787.6 10804.2 10864.5 10919.2 11052.7 3300.2 3303.4 3368.0 3382.6 3387.6 49254.5 49351.0 49529.5 62225.7 62998.4 9202.1 9219.9 9338.8 9382.9 9428.0 18282.6 18301.0 18381.8 18408.4 18409.4 6253.4 6416.3 6429.9 6455.0 6666.8 3427.2 3478.7 3493.9 3532.8 3589.2 2957.0 3065.0 3065.1 3066.1 3083.5 477.6 486.4 499.1 500.1 504.5 501.0 567.0 570.5 572.9 600.7 7742.9 8053.4 8078.8 8143.1 8256.8 474.1 503.4 556.6 560.8 621.9 3694.2 3714.9 3714.9 3791.7 3962.1 50112.2 83975.6 85388.7 93046.5 93608.0 76415.6 77159.6 77605.6 78016.6 80148.0 67954.3 71200.6 71625.3 71996.3 72247.3 6886.2 7061.8 7208.2 7215.6 7250.0 40901.6 41210.4 42114.8 42843.4 43077.4 54689.7 61839.4 62675.4 64032.4 64275.4 9457.2 9516.1 9837.1 9900.1 10103.0 10296.5 10397.3 10442.7 10532.4 10652.5 10073.3 10184.1 10207.8 10236.5 10447.2 9858.8 9959.1 10079.8 10319.1 10587.7 9970.0 9984.4 10007.6 10224.9 10401.1 8148.2 8356.7 8473.2 8759.5 8902.3 8103.8 8477.2 9027.7 9052.3 9422.4 12:01:50 INFO - PROCESS | 23905 | -------- Summary: end -------- 12:01:50 INFO - PROCESS | 23905 | 12:01:51 INFO - TEST-INFO | 23905: exit 0 12:01:51 INFO - TEST-OK | dromaeo_css | took 1120611ms 12:01:51 INFO - TEST-START | kraken 12:01:51 INFO - operating with platform_type : linux_ 12:01:51 INFO - Initialising browser for kraken test... 12:01:52 INFO - TEST-INFO | started process 24262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKb2xkN/profile http://localhost:45233/getInfo.html) 12:01:56 INFO - PROCESS | 24262 | __metrics Screen width/height:1600/1200 12:01:56 INFO - PROCESS | 24262 | colorDepth:24 12:01:56 INFO - PROCESS | 24262 | Browser inner width/height: 1024/697 12:01:56 INFO - PROCESS | 24262 | __metrics 12:01:57 ERROR - PROCESS | 24262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 12:01:58 INFO - TEST-INFO | 24262: exit 0 12:01:58 INFO - Browser initialized. 12:01:58 INFO - Running cycle 1/1 for kraken test... 12:01:58 INFO - TEST-INFO | started process 24385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKb2xkN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:10 INFO - PROCESS | 24385 | RSS: Main: 183513088 12:02:10 INFO - PROCESS | 24385 | 12:02:13 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45233/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:14 INFO - PROCESS | 24385 | RSS: Main: 197148672 12:02:14 INFO - PROCESS | 24385 | 12:02:17 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45233/tests/kraken/driver.html?testName=audio-dft) 12:02:18 INFO - PROCESS | 24385 | RSS: Main: 195420160 12:02:18 INFO - PROCESS | 24385 | 12:02:21 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45233/tests/kraken/driver.html?testName=audio-fft) 12:02:21 INFO - PROCESS | 24385 | RSS: Main: 191848448 12:02:21 INFO - PROCESS | 24385 | 12:02:23 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45233/tests/kraken/driver.html?testName=audio-oscillator) 12:02:24 INFO - PROCESS | 24385 | RSS: Main: 192577536 12:02:24 INFO - PROCESS | 24385 | 12:02:26 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:27 INFO - PROCESS | 24385 | RSS: Main: 192602112 12:02:27 INFO - PROCESS | 24385 | 12:02:30 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45233/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:31 INFO - PROCESS | 24385 | RSS: Main: 193744896 12:02:31 INFO - PROCESS | 24385 | 12:02:34 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45233/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:35 INFO - PROCESS | 24385 | RSS: Main: 190783488 12:02:35 INFO - PROCESS | 24385 | 12:02:38 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45233/tests/kraken/driver.html?testName=json-parse-financial) 12:02:38 INFO - PROCESS | 24385 | RSS: Main: 192409600 12:02:38 INFO - PROCESS | 24385 | 12:02:40 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:41 INFO - PROCESS | 24385 | RSS: Main: 192225280 12:02:41 INFO - PROCESS | 24385 | 12:02:42 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:43 INFO - PROCESS | 24385 | RSS: Main: 192114688 12:02:43 INFO - PROCESS | 24385 | 12:02:45 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:46 INFO - PROCESS | 24385 | RSS: Main: 192409600 12:02:46 INFO - PROCESS | 24385 | 12:02:49 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:50 INFO - PROCESS | 24385 | RSS: Main: 193007616 12:02:50 INFO - PROCESS | 24385 | 12:02:53 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:53 INFO - PROCESS | 24385 | RSS: Main: 192798720 12:02:53 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | Cycle 1(1): loaded http://localhost:45233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45233/tests/kraken/driver.html?testName=ai-astar) 12:02:55 INFO - PROCESS | 24385 | RSS: Main: 195551232 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | __start_tp_report 12:02:55 INFO - PROCESS | 24385 | _x_x_mozilla_page_load 12:02:55 INFO - PROCESS | 24385 | _x_x_mozilla_page_load_details 12:02:55 INFO - PROCESS | 24385 | |i|pagename|runs| 12:02:55 INFO - PROCESS | 24385 | |0;ai-astar;108;115;116;117;114;117;117;114;117;114 12:02:55 INFO - PROCESS | 24385 | |1;audio-beat-detection;162;133;129;173;134;132;132;130;161;131 12:02:55 INFO - PROCESS | 24385 | |2;audio-dft;174;167;163;162;164;164;168;167;162;164 12:02:55 INFO - PROCESS | 24385 | |3;audio-fft;76;77;77;104;76;77;76;78;99;76 12:02:55 INFO - PROCESS | 24385 | |4;audio-oscillator;84;86;111;86;84;84;104;84;84;121 12:02:55 INFO - PROCESS | 24385 | |5;imaging-gaussian-blur;117;118;117;118;118;119;120;118;118;120 12:02:55 INFO - PROCESS | 24385 | |6;imaging-darkroom;147;148;149;148;148;149;149;149;148;148 12:02:55 INFO - PROCESS | 24385 | |7;imaging-desaturate;85;85;85;86;85;86;86;86;85;85 12:02:55 INFO - PROCESS | 24385 | |8;json-parse-financial;64;62;66;62;66;63;63;66;63;64 12:02:55 INFO - PROCESS | 24385 | |9;json-stringify-tinderbox;68;68;67;67;71;67;67;68;68;67 12:02:55 INFO - PROCESS | 24385 | |10;stanford-crypto-aes;91;86;86;86;86;95;89;102;92;87 12:02:55 INFO - PROCESS | 24385 | |11;stanford-crypto-ccm;154;147;159;146;149;142;149;152;187;153 12:02:55 INFO - PROCESS | 24385 | |12;stanford-crypto-pbkdf2;177;183;186;183;178;178;182;182;176;176 12:02:55 INFO - PROCESS | 24385 | |13;stanford-crypto-sha256-iterative;73;70;75;72;78;75;73;71;70;76 12:02:55 INFO - PROCESS | 24385 | __end_tp_report 12:02:55 INFO - PROCESS | 24385 | __start_cc_report 12:02:55 INFO - PROCESS | 24385 | _x_x_mozilla_cycle_collect,879 12:02:55 INFO - PROCESS | 24385 | __end_cc_report 12:02:55 INFO - PROCESS | 24385 | __startTimestamp1477249375942__endTimestamp 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | ------- Summary: start ------- 12:02:55 INFO - PROCESS | 24385 | Number of tests: 14 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.50 stddev:2.77 (2.4%) stddev-sans-first:1.41 12:02:55 INFO - PROCESS | 24385 | Values: 108.0 115.0 116.0 117.0 114.0 117.0 117.0 114.0 117.0 114.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:133.50 stddev:16.67 (12.5%) stddev-sans-first:15.98 12:02:55 INFO - PROCESS | 24385 | Values: 162.0 133.0 129.0 173.0 134.0 132.0 132.0 130.0 161.0 131.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:3.66 (2.2%) stddev-sans-first:2.24 12:02:55 INFO - PROCESS | 24385 | Values: 174.0 167.0 163.0 162.0 164.0 164.0 168.0 167.0 162.0 164.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:10.57 (13.7%) stddev-sans-first:11.02 12:02:55 INFO - PROCESS | 24385 | Values: 76.0 77.0 77.0 104.0 76.0 77.0 76.0 78.0 99.0 76.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.00 stddev:13.87 (16.5%) stddev-sans-first:14.34 12:02:55 INFO - PROCESS | 24385 | Values: 84.0 86.0 111.0 86.0 84.0 84.0 104.0 84.0 84.0 121.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 12:02:55 INFO - PROCESS | 24385 | Values: 117.0 118.0 117.0 118.0 118.0 119.0 120.0 118.0 118.0 120.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 12:02:55 INFO - PROCESS | 24385 | Values: 147.0 148.0 149.0 148.0 148.0 149.0 149.0 149.0 148.0 148.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 12:02:55 INFO - PROCESS | 24385 | Values: 85.0 85.0 85.0 86.0 85.0 86.0 86.0 86.0 85.0 85.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.60 (2.5%) stddev-sans-first:1.69 12:02:55 INFO - PROCESS | 24385 | Values: 64.0 62.0 66.0 62.0 66.0 63.0 63.0 66.0 63.0 64.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 12:02:55 INFO - PROCESS | 24385 | Values: 68.0 68.0 67.0 67.0 71.0 67.0 67.0 68.0 68.0 67.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:88.00 stddev:5.25 (6.0%) stddev-sans-first:5.56 12:02:55 INFO - PROCESS | 24385 | Values: 91.0 86.0 86.0 86.0 86.0 95.0 89.0 102.0 92.0 87.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:152.50 stddev:12.59 (8.3%) stddev-sans-first:13.35 12:02:55 INFO - PROCESS | 24385 | Values: 154.0 147.0 159.0 146.0 149.0 142.0 149.0 152.0 187.0 153.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:182.00 stddev:3.51 (1.9%) stddev-sans-first:3.54 12:02:55 INFO - PROCESS | 24385 | Values: 177.0 183.0 186.0 183.0 178.0 178.0 182.0 182.0 176.0 176.0 12:02:55 INFO - PROCESS | 24385 | 12:02:55 INFO - PROCESS | 24385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:2.67 (3.6%) stddev-sans-first:2.83 12:02:55 INFO - PROCESS | 24385 | Values: 73.0 70.0 75.0 72.0 78.0 75.0 73.0 71.0 70.0 76.0 12:02:55 INFO - PROCESS | 24385 | -------- Summary: end -------- 12:02:55 INFO - PROCESS | 24385 | 12:02:57 INFO - TEST-INFO | 24385: exit 0 12:02:57 INFO - TEST-OK | kraken | took 65221ms 12:02:57 INFO - SUITE-END | took 1185s 12:02:57 INFO - Completed test suite (00:19:46) 12:02:57 INFO - javascript benchmark 12:02:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6268.235064554275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.0988259050623, 2629.8553579553122, 2635.196265139132, 2655.920322390328, 2656.9070082547105, 4707.90584188316, 4776.761161941907, 4821.710697358157, 4823.758812059392, 4847.733374664392, 4737.170995075865, 4782.617390608761, 4799.5680388765, 4853.199222128344, 4860.4896485869, 4362.694611377205, 4392.428984232045, 4454.910901781963, 4485.686001979862, 4555.453345598533, 4417.42573465449, 4483.394741709876, 4518.8418405355815, 4550.817967281305, 4569.4516658001085, 4327.1345730853955, 4343.2182207202695, 4344.196323680129, 4483.641308695296, 4527.728336299832, 4386.846460373904, 4399.428074350314, 4409.250427427345, 4471.910561788779, 4477.6417886569, 4372.27857403528, 4375.6937014409, 4405.9118817623785, 4424.424824772791, 4425.004374015853, 4658.208104622222, 4671.205894997858, 4760.285957106462, 4780.0, 4783.3064205690325, 5107.20838270065, 5200.947990520084, 5204.115300398941, 5206.713630750307, 5262.973685131588, 5229.790808367698, 5232.319798426218, 5239.528442440161, 5242.842714718565, 5295.947040529584, 4742.170120228946, 4844.370231869834, 4848.151573474628, 4850.078485087822, 4851.563359297609, 5222.190560463135, 5258.158694608845, 5274.156135018456, 5285.788568457296, 5294.258803767476, 5007.098722230034, 5043.445221025684, 5072.771725272371, 5076.390833100052, 5085.796568137233, 5165.276861239429, 5169.121249387613, 5179.119549676564, 5216.765245563959, 5237.423883372826, 5143.8456846294675, 5166.819161329336, 5173.5602473789395, 5174.24973378858, 5188.507091826271, 5150.330457040561, 5158.123119069767, 5159.458256883048, 5161.458046905096, 5209.453007434241, 4252.55348188442, 4296.054867929113, 4306.913861722748, 4352.129574085196, 4359.062801497693, 3779.225258821935, 3783.129880127586, 3786.3752480840353, 3826.9808650956566, 3839.577646458887, 4507.526709695435, 4512.684112112121, 4513.390692256569, 4517.954820451819, 4556.3165525170825, 5059.06407314648, 5063.1645778446145, 5119.155339368963, 5143.8456846294675, 5200.713960732196, 4470.485894122153, 4476.731396116244, 4506.639468842484, 4510.661700372485, 4531.229690952546, 4605.217113090783, 4608.331791890158, 4610.377599024089, 4617.953820461819, 4664.836730714409, 4709.105269998689, 4767.141914455431, 4818.566329030404, 4835.057163853015, 4841.878953026203, 5161.225816127611, 5206.97396513015, 5209.453007434165, 5258.1849813279005, 5269.736513174403, 4762.809487620457, 4854.83008094715, 4855.1260773061185, 4861.927071093865, 4923.433805112458, 5057.924131137962, 5069.138246498178, 5140.30605868203, 5143.279940808365, 5161.638685291993, 5012.548870601663, 5020.121478741133, 5076.162433198629, 5215.739213039409, 5235.0, 5050.3182070420025, 5089.5419412251595, 5109.948900510947, 5113.693178409308, 5127.4872512748425, 4981.153203955409, 5017.67385119966, 5051.040302342543, 5056.721880296619, 5057.924131138109, 4951.678140920829, 4962.801487940442, 4988.700677959189, 4998.725070121178, 5055.443901170942, 4935.111679897653, 4996.400431948189, 5052.5705315048635, 5099.6175286852895, 5104.770285337243, 4964.081644895706, 4998.6750861193905, 5003.374578177728, 5003.599712023102, 5043.344365232643], "value": 4736.448516755609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.502737481517, 541.2152379050378, 544.0316237097966, 552.6794459213655, 556.7299859568109, 37700.434493482586, 39173.41239881404, 39206.21587568247, 42573.574264257346, 42683.573164268346, 40060.19879602406, 40255.396169057414, 40261.19477610446, 40284.59715402845, 40395.79802100993, 7622.161562228164, 7751.984484034164, 7754.379649628045, 7757.961210193941, 7764.611769411535, 7529.397648188159, 7576.318131368176, 7667.42494312926, 7668.654910529011, 7670.769876903674, 7600.923990760105, 7670.27132422419, 7689.192634773352, 7740.303372696456, 7746.961265193666, 7685.769426917173, 7704.345130663873, 7717.151113377524, 7717.3054425101445, 7717.65270562826, 7693.9615301923695, 7751.457397982143, 7757.922420775776, 7761.7671469855995, 7762.262585054411, 37672.811635941645, 37981.43027854584, 38132.42801357954, 38145.0, 38183.427248591295, 2975.4197931403387, 2989.5814585957983, 3016.547517872315, 3229.7416206703642, 3276.475763877792, 27706.584401234, 27888.16335509938, 28273.15180544587, 28431.857840710873, 28467.288317792012, 3467.9653203467897, 3475.7566970312087, 3518.8064656443885, 3534.8232588370734, 3543.557055368079, 228618.0, 229009.0, 229373.0, 229504.0, 229867.0, 49602.0, 49799.502004979484, 49870.0, 49872.750636247314, 50016.24975625369, 52544.737276313375, 52723.0, 52791.73604131955, 52836.73581632067, 53134.46865531372, 13044.41300141496, 13190.802137967938, 13216.140950838164, 13279.336033198302, 13322.267275299952, 10195.490225488697, 10204.591816327413, 10222.386656800616, 10259.0, 10314.43270620123, 14364.35360408784, 15794.447194348142, 15870.52388428349, 15923.203839807964, 15985.44050958211, 5959.4934430573885, 6005.279366475964, 6006.699665016732, 6060.908637044433, 6152.723127459186, 732.7508647060025, 824.5228409735076, 881.1056777370974, 882.6866462405882, 958.8609651600478, 25771.0, 27932.0, 28126.29684257869, 28197.295067623472, 28278.15165545037, 924.9722508324761, 959.203860795538, 1019.3628981886321, 1029.3669393323053, 1031.9535620897077, 13744.725105497833, 14551.927240363942, 14569.708605827824, 14589.416423342947, 14819.110853348619, 341467.0, 342313.0, 348109.0, 349222.0, 349337.0, 49001.75499122553, 49267.26099108516, 49304.50695493071, 49353.75323123361, 49355.50644493581, 1176.353005846781, 1198.406788639629, 1208.5347141350644, 1215.5077193736552, 1216.0575553945587, 24944.37639059038, 25134.874325628254, 25867.741322586535, 26125.477490450463, 26263.0, 42081.36877946772, 43120.0, 43168.0, 43193.0, 43264.78367608142, 312206.0, 312961.0, 313881.0, 314109.0, 314948.0, 23560.29319120429, 24027.159049433187, 24094.470080641982, 24249.63625545583, 24528.264152075466, 39845.40231896582, 40072.0, 40707.0, 41558.79220603878, 42116.36825447682, 35209.0, 35338.82330588331, 35494.46758298679, 35845.0, 36956.44565331468, 34862.47706284357, 34948.825255873555, 35348.823255884585, 35598.64401355953, 36354.63645363618, 33827.66172338245, 34301.828490857384, 34547.48178777371, 34828.825855871575, 34904.47643285403, 31163.688363116984, 32373.67626323801, 32782.88562586551, 32822.34355312928, 32880.50679239765, 24492.0, 24934.0, 24935.0, 25022.74977250277, 25227.74772252254], "value": 16956.337911651353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.50900502803626, 364.89600463867805, 366.10669965284706, 373.058028478093, 387.1733848234021, 15445.768313475306, 15694.0, 16874.156292185387, 17051.91474042628, 17125.14374281287, 16348.346066157339, 16647.25087371068, 16704.331826726917, 16823.327066917307, 16913.83086169138, 4755.120302743986, 5099.031184075033, 5104.795808167669, 5108.131617624994, 5112.846614601568, 4854.320395144682, 4985.102681517325, 5010.398752149747, 5062.367204099488, 5078.1874900016, 4998.650094493387, 5001.574866136383, 5009.298698182258, 5011.824586139486, 5035.446100928895, 4858.902821943577, 4997.575206107485, 4998.775055122528, 5005.074061298653, 5019.196928491424, 4446.955530444687, 4494.8876278092985, 4498.640108791322, 4500.909981800346, 4513.7517436540975, 19443.805561944482, 19929.9003504983, 19970.800291997184, 20328.89835550813, 20520.897395513075, 1776.5558610347414, 1842.5485755989735, 1855.9350422735274, 1869.5045812859603, 1982.9405117846488, 8918.73243802687, 8935.687250946186, 9006.954965225197, 9185.0, 9310.534473276377, 1657.801063872331, 1670.181611010596, 1681.3778901806288, 1690.6365131496664, 1772.1759381887484, 57742.7112864433, 60008.39991600115, 60025.699871500365, 61333.693331533505, 67364.0, 9256.352055356061, 9498.762530936643, 9591.568379422943, 9820.116189542832, 9957.502124893726, 13385.996050296268, 13398.196108233537, 13400.664983375298, 13404.463821447032, 13408.128471649312, 6662.167229096363, 6835.179778426621, 6970.093887794555, 7095.764834077249, 7157.57054576727, 6237.376262373817, 6462.612243265419, 6723.0, 6757.087793147961, 6867.553609015398, 4170.395292682605, 4229.048464095554, 4268.317069268902, 4270.338097594816, 4330.480342358937, 1754.1141723429587, 1771.1852547828144, 1786.9553261168314, 1831.5878927241265, 1907.4182374375948, 798.4131663227523, 839.2195258409615, 867.5618812499773, 938.4510061613896, 942.5004747483845, 15875.52373428799, 16512.587185320463, 16904.239309231114, 17252.309907603554, 17275.222614982355, 807.7495976247382, 843.9282660973763, 865.3164000439708, 883.8718385834018, 924.9445033298024, 9035.277177825757, 9228.5847136879, 9559.952200238955, 9627.374220675634, 9629.807403851884, 336124.0, 338161.0, 340187.0, 343572.0, 351879.0, 44594.55405445969, 44609.55390446054, 57815.13277300844, 73103.63448182725, 75762.62118689482, 869.4783130121876, 881.8104107616894, 894.5706061090583, 895.5925054100369, 915.1443400420628, 15430.22848857575, 15552.30014649321, 15817.841821582097, 15836.208189590705, 15849.0, 34767.0, 36963.44554831734, 37093.0, 37591.0, 37847.61971415547, 49369.50630493649, 49509.50490495049, 49738.75130624323, 50001.74999124981, 50297.49702502928, 6318.526110541819, 7221.638918053971, 7300.96349518249, 7340.889886651811, 7624.0, 8188.7952801180445, 10526.473676316307, 10630.415327156772, 10703.839442408525, 11314.20800543987, 8482.140626015273, 8838.867416988622, 9001.36990410665, 9057.275417966679, 9546.665866694633, 8533.74398768038, 9563.0, 9849.359791613522, 9887.406755594688, 9989.200863930722, 9445.905540944503, 9496.14534691881, 9500.907395649312, 9616.75958101053, 10157.593696252363, 6145.784897528565, 7416.25837416254, 7418.703251870081, 7478.214787447239, 7601.505902116345, 9147.359684821999, 9162.221211197122, 9207.631694732136, 9221.861672075058, 9716.976456009914], "value": 7776.918503488997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.657835541115, 1399.398258748738, 1503.5789978805938, 1690.9577260568492, 1704.4204970310093, 6556.803295901131, 6802.863942721143, 7379.2620737926245, 7959.243871832174, 8051.677932882685, 7526.172121066678, 7881.842363152748, 7885.211478852112, 7899.4075444341615, 7905.604719764017, 2104.5054412213117, 2137.1237792505076, 2137.187868609926, 2137.348108826807, 2140.646793279107, 2067.948301292472, 2099.6850472429182, 2169.240765731989, 2179.3353027326657, 2179.69484272202, 2125.0968338456173, 2143.8606490578063, 2154.5367745934623, 2166.869987800729, 2183.8471307008517, 2094.937151885446, 2107.2413930984835, 2107.7365329333834, 2108.8312934965243, 2110.177030957928, 2041.2855500574829, 2062.175129948018, 2082.344061620585, 2082.875027498355, 2083.906224219914, 7768.067831860157, 7855.096663883669, 7895.092064412609, 7925.2960613468385, 7925.762227133196, 4462.910741785178, 4566.246569316058, 4573.336866154389, 4605.217113090783, 4608.815647374101, 2774.5005898938184, 2813.4091840713477, 2834.6393731009025, 2862.5992361069466, 2870.2967772895568, 884.2263019857625, 904.3940559824933, 918.5728636184207, 928.1136514628514, 1737.8001529824105, 10457.895421045845, 10515.106215971651, 10596.152307815357, 10631.574737010511, 10662.040416362486, 3733.9626603733614, 4002.4396584478195, 4007.358822588372, 4106.630403263721, 4114.156597897424, 8362.414630975773, 8364.0, 8367.0, 8374.623141958626, 8376.288015518627, 4494.685372023992, 4528.139653465831, 4535.160995215896, 4537.910901383711, 4538.047010127844, 3547.0, 3650.178709790329, 3977.3039718049226, 4178.979105104455, 4208.137331846964, 3236.4983427568764, 3301.9339613207603, 3409.147713071732, 3437.5874895012757, 3453.671901169385, 980.7253968888723, 1002.4386343647581, 1004.0, 1006.8320747932363, 1012.4836333469983, 801.4790386248985, 829.3158144530786, 832.8625776746769, 833.6290350793838, 835.3317346123077, 4968.527989840959, 5141.151709967813, 5209.817656382009, 5268.789248430096, 5333.120035194227, 414.1861242658131, 419.3248869320392, 430.05602702069285, 430.2749866475, 435.7799311347749, 3373.8819141330428, 3509.385857474983, 3509.719222462248, 3672.1554042569824, 3674.0447483654443, 9097.13577210164, 9349.626014959462, 9500.714978550655, 9601.039896010343, 9617.903820961841, 9565.04349565038, 9565.139137477521, 9571.28215383849, 9571.712848614414, 9579.13787759105, 7230.0, 7294.270572942663, 7324.926750732425, 7327.230640782747, 7335.926640733631, 4921.803127874845, 4941.184704523857, 4953.678010929278, 4966.726830024383, 5354.7858085676135, 8614.396992210484, 8635.611397487253, 8721.215090641872, 8735.956320218358, 8811.779705507413, 8704.173103555153, 8909.821803563762, 8919.331050171133, 8979.371443998858, 9029.006809250846, 6217.720202590804, 6242.875142497034, 6248.500119990299, 6290.968545157428, 6330.303666596578, 7309.634518273959, 7355.374793142642, 7360.0, 7365.558066516026, 7398.630068496661, 6426.035680226152, 6635.0, 6724.899126513008, 6742.224644165984, 6885.862282754417, 6436.581622194542, 6726.730930762715, 6794.3545363190415, 6858.554193977376, 6900.171979362509, 5949.167116603766, 6054.061620448838, 6113.449789518964, 6150.10823430609, 6174.783882564088, 4425.269830477935, 4500.234960056864, 4522.4573051234065, 4575.679702420799, 4628.0, 4249.6387807036745, 4376.277914144258, 4384.210842048462, 4485.775711214361, 4491.7754112293605], "value": 3971.9775755691153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.5858763380732, 291.21953165516413, 297.0494417862838, 311.3819069147741, 316.7070459824662, 5027.547520723134, 5049.671771334861, 5059.6964182149095, 5090.8472745817635, 5093.134167191577, 4941.530554597316, 4973.72644504553, 4992.600591952644, 5003.47463516331, 5018.974905125469, 3975.6223158799867, 3998.9600103999023, 4002.9199416011734, 4005.259027079985, 4006.61937115975, 3847.615238476158, 3914.9804250978705, 3922.5096862892137, 3982.800859957005, 4012.4752594014235, 3886.650201481866, 3899.6880249579967, 3904.6681032112306, 3905.1799122184375, 3924.7841368724853, 3898.0, 3900.771257054033, 3920.7843568603716, 3933.1150491139265, 3945.6054394560315, 3325.817080060596, 3450.7584469087174, 3454.9827250863837, 3462.515247865301, 3471.3057388522398, 4838.177509823338, 4841.903161936777, 4854.660173787836, 4862.200985635338, 4877.658563900528, 4468.128714900596, 4486.506484286726, 4509.436320459942, 4509.526499717548, 4515.277555591122, 5029.974850125763, 5181.911798522315, 5203.089459344599, 5216.739163041832, 5229.294045303911, 3785.2429514097016, 3788.090858194041, 3795.9430608540893, 3805.353089974711, 3812.6377994090517, 5402.189671549259, 5470.480304371078, 5489.972550137224, 5495.8351249462185, 5514.6691198528215, 3804.353259945816, 3856.093817952779, 3908.6710518423874, 3913.5108111486065, 3926.1166237596312, 3881.5342158941107, 3895.9805200973815, 3902.453656488094, 3910.2570511602703, 3915.393114067324, 4421.977890110529, 4426.955730442719, 4429.269170586817, 4430.601245887886, 4453.643708503312, 5179.2749015137915, 5181.637285390062, 5212.374515058217, 5263.921041184385, 5266.552343050807, 1294.6310301564008, 1359.8300212473441, 1370.7327071221216, 1371.3475262308893, 1375.9449622015206, 871.6426265231224, 879.4283715584921, 889.7019498468086, 898.8247291778172, 907.8456662367413, 4054.8378064877074, 4056.553779084298, 4058.431819545266, 4064.4309796628495, 4090.5091389033505, 4673.579377855941, 4680.438347398334, 4685.554872287127, 4725.228039485193, 4729.62163026957, 4023.4970628671417, 4062.532808727034, 4082.408050832613, 4087.3854827343625, 4146.91706165875, 2485.260317777563, 2664.520386330479, 2868.856557172133, 2870.454613623405, 2882.8126171798767, 4711.434627844681, 4875.634327425457, 4882.926756098661, 5019.39379398589, 5024.834354356732, 5497.835064948058, 5498.285222920995, 5514.448555144534, 5526.0, 5560.388357280696, 4832.251001094836, 5041.6722913010535, 5049.813293875936, 5070.771815268396, 5083.644144909821, 5312.4156342803035, 5353.22378255143, 5371.248025276543, 5420.349558052902, 5430.212619170277, 5275.920861187162, 5287.576993840406, 5292.179712144623, 5307.708076055854, 5312.442193569619, 4708.976455117702, 4963.0, 5054.924176137288, 5056.115179843586, 5072.137736584863, 3730.626937306356, 3738.0, 3749.418840079792, 3755.9812200938823, 3756.3050835595504, 5384.865378365415, 5392.946070539245, 5437.32033495813, 5444.210589464585, 5480.150576660624, 4985.581992733449, 5216.608754343363, 5285.68285902847, 5317.574594032545, 5324.653897496651, 5239.240310155083, 5276.525112739719, 5296.0, 5302.337207849019, 5344.866378340573, 5191.844244672666, 5237.921431178612, 5247.475252474875, 5263.23683065961, 5267.446918073547, 4955.571769832828, 5266.446398312431, 5309.628326017141, 5329.1206950852675, 5340.092184328596, 5222.791088356423, 5240.606954478506, 5244.711540865136, 5256.737163141904, 5258.737063146904], "value": 3910.262943228275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.4042302350907, 683.5966779600035, 691.3915754136361, 711.8860982242842, 717.9102612173479, 12064.939675301623, 12828.615141545744, 13005.60983170504, 13242.668933276673, 14152.50466233682, 13457.73084538311, 13584.728305433886, 13782.793258101137, 13800.723985520284, 13801.723965520683, 763.2710761223019, 784.2001158818002, 796.1242633103569, 805.7985503624094, 811.2658044469764, 813.3411936331561, 820.335528222142, 820.4666966471782, 821.3962737388044, 822.7120507822244, 842.9789255268637, 843.8860753798251, 843.9324854011695, 844.2865778417228, 844.8056946902216, 836.2306677856386, 836.8870202522643, 838.2078935406043, 838.651959436833, 841.474078700812, 615.9137720719103, 616.0943413182614, 616.5468380740152, 619.2414292491707, 619.3187493756876, 13438.395272212676, 13455.529056482976, 13481.932590337083, 13505.729885402336, 13507.86492135076, 12727.109102362838, 13039.0, 13193.670158246025, 13326.333683315892, 13497.730045399136, 10787.6224332148, 10804.243702940797, 10864.511097000654, 10919.235653504258, 11052.723681907935, 3300.1914530940076, 3303.3888730584918, 3368.0, 3382.5602671652773, 3387.6442973487924, 49254.50745492571, 49351.0, 49529.50470495285, 62225.6888715558, 62998.37001629971, 9202.079792020744, 9219.861702074475, 9338.813223735488, 9382.906170938204, 9427.952860235655, 18282.634347313244, 18301.0, 18381.81618183828, 18408.410359979942, 18409.43519800805, 6253.374662533801, 6416.326285740023, 6429.903551446732, 6454.9677251614385, 6666.799996000128, 3427.160345715266, 3478.7390945679176, 3493.9126521837156, 3532.752707310515, 3589.1565482111682, 2956.9704302956693, 3064.9540256896166, 3065.0651551277074, 3066.0801759472515, 3083.5066389377594, 477.59404506169477, 486.365293292257, 499.0966350904874, 500.1372632209482, 504.4955044955045, 500.9549140577366, 566.9971650141723, 570.4837122404231, 572.8625129968777, 600.729457198023, 7742.877282793963, 8053.355731541463, 8078.757637270891, 8143.063547691972, 8256.8348633027, 474.0696753760846, 503.4311228311984, 556.6075916478873, 560.80932482956, 621.9409156130251, 3694.2057457646197, 3714.9071273217846, 3714.9442758358646, 3791.658750712449, 3962.1481381503113, 50112.24831627528, 83975.580122099, 85388.7191692125, 93046.53476732709, 93608.0, 76415.61792191115, 77159.61420192975, 77605.6119719409, 78016.60991695005, 80148.0, 67954.3204567948, 71200.64399677969, 71625.28374716185, 71996.28003719896, 72247.2775272251, 6886.24251332343, 7061.788146355618, 7208.17106032792, 7215.567065975848, 7250.0, 40901.59098408978, 41210.38184427176, 42114.789426052674, 42843.357349640406, 43077.35383969306, 54689.71068327194, 61839.381606183364, 62675.37324626878, 64032.399190020624, 64275.35724642694, 9457.19613832832, 9516.143547080796, 9837.114659680663, 9900.108990190918, 10103.040211179927, 10296.485175741333, 10397.33783649536, 10442.68671939843, 10532.368057916243, 10652.520636571218, 10073.345232559861, 10184.134348580454, 10207.84688229692, 10236.53935572886, 10447.223971924639, 9858.802823943624, 9959.05388988045, 10079.770467553086, 10319.122874555747, 10587.735306617396, 9970.0, 9984.400935943866, 10007.599696012368, 10224.897751022394, 10401.063904248655, 8148.185181481805, 8356.66573337084, 8473.195046470575, 8759.474431534129, 8902.332325075517, 8103.83792324162, 8477.194666506672, 9027.729168124966, 9052.321075919464, 9422.434653920787], "value": 6252.002906606717, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 116.0, 117.0, 114.0, 117.0, 117.0, 114.0, 117.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 129.0, 173.0, 134.0, 132.0, 132.0, 130.0, 161.0, 131.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 167.0, 163.0, 162.0, 164.0, 164.0, 168.0, 167.0, 162.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 104.0, 76.0, 77.0, 76.0, 78.0, 99.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 111.0, 86.0, 84.0, 84.0, 104.0, 84.0, 84.0, 121.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 120.0, 118.0, 118.0, 120.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 86.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 66.0, 62.0, 66.0, 63.0, 63.0, 66.0, 63.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 71.0, 67.0, 67.0, 68.0, 68.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 86.0, 86.0, 86.0, 95.0, 89.0, 102.0, 92.0, 87.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 147.0, 159.0, 146.0, 149.0, 142.0, 149.0, 152.0, 187.0, 153.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 183.0, 186.0, 183.0, 178.0, 178.0, 182.0, 182.0, 176.0, 176.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 75.0, 72.0, 78.0, 75.0, 73.0, 71.0, 70.0, 76.0], "value": 73.3, "unit": "score"}]}]} 12:02:57 INFO - Return code: 0 12:02:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:02:57 ERROR - # TBPL SUCCESS # 12:02:57 INFO - Running post-action listener: _resource_record_post_action 12:02:57 INFO - [mozharness: 2016-10-23 19:02:57.743623Z] Finished run-tests step (success) 12:02:57 INFO - Running post-run listener: _resource_record_post_run 12:02:57 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 408604672; Read time: 452; Write time: 310372 12:02:57 INFO - TinderboxPrint: CPU usage
13.4% 12:02:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 452 12:02:57 INFO - TinderboxPrint: I/O write bytes / time
408,604,672 / 310,372 12:02:57 INFO - TinderboxPrint: CPU idle
8,304.2 (86.6%) 12:02:57 INFO - TinderboxPrint: CPU user
1,226.3 (12.8%) 12:02:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:02:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116101120; Read time: 0; Write time: 108084 12:02:57 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 291590144; Read time: 452; Write time: 202260 12:02:58 INFO - Running post-run listener: _upload_blobber_files 12:02:58 INFO - Blob upload gear active. 12:02:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:02:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:00 INFO - (blobuploader) - INFO - Done attempting. 12:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:03 INFO - (blobuploader) - INFO - Done attempting. 12:03:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:03:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:03:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:03:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:03:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:03:04 INFO - (blobuploader) - INFO - Done attempting. 12:03:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:03:04 INFO - Return code: 0 12:03:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:03:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:03:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e845b3bb5476a2b79097a687a169ef92d8ac5750befab477e5293a53c5d06ad4f2b049a0bd01447fe329c4c273e88e9bf33faefb8c5ff4616c2f169336447c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6ebd02e782c3ec69ae9bebd98d6436a3af12f7c6d31b9037fc4cddcb12f8753e96822c7205ddc0c20860325734dca55b4324f81034a3ca672595609766c467c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e946c6e9388e3d2ecc7d380f3dd8c5ea25b1fc6ffd121cbebbf08d296ed94f8cfb6103ace16e0bff31d921625aa5f8641a6850a36f2c6e70c3e26160b39a9"} 12:03:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:03:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:03:04 INFO - Contents: 12:03:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e845b3bb5476a2b79097a687a169ef92d8ac5750befab477e5293a53c5d06ad4f2b049a0bd01447fe329c4c273e88e9bf33faefb8c5ff4616c2f169336447c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6ebd02e782c3ec69ae9bebd98d6436a3af12f7c6d31b9037fc4cddcb12f8753e96822c7205ddc0c20860325734dca55b4324f81034a3ca672595609766c467c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e946c6e9388e3d2ecc7d380f3dd8c5ea25b1fc6ffd121cbebbf08d296ed94f8cfb6103ace16e0bff31d921625aa5f8641a6850a36f2c6e70c3e26160b39a9"} 12:03:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:03:04 INFO - Copying logs to upload dir... 12:03:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:03:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.146127 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-23 12:03:03.825280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 12:03:03.829932) ========= 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=836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e845b3bb5476a2b79097a687a169ef92d8ac5750befab477e5293a53c5d06ad4f2b049a0bd01447fe329c4c273e88e9bf33faefb8c5ff4616c2f169336447c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6ebd02e782c3ec69ae9bebd98d6436a3af12f7c6d31b9037fc4cddcb12f8753e96822c7205ddc0c20860325734dca55b4324f81034a3ca672595609766c467c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e946c6e9388e3d2ecc7d380f3dd8c5ea25b1fc6ffd121cbebbf08d296ed94f8cfb6103ace16e0bff31d921625aa5f8641a6850a36f2c6e70c3e26160b39a9"} build_url:https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/O6gVBLcNQ9SsQ1s3CkzOGg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e845b3bb5476a2b79097a687a169ef92d8ac5750befab477e5293a53c5d06ad4f2b049a0bd01447fe329c4c273e88e9bf33faefb8c5ff4616c2f169336447c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6ebd02e782c3ec69ae9bebd98d6436a3af12f7c6d31b9037fc4cddcb12f8753e96822c7205ddc0c20860325734dca55b4324f81034a3ca672595609766c467c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/951e946c6e9388e3d2ecc7d380f3dd8c5ea25b1fc6ffd121cbebbf08d296ed94f8cfb6103ace16e0bff31d921625aa5f8641a6850a36f2c6e70c3e26160b39a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 12:03:03.859806) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 12:03:03.860150) ========= 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=836cfdc75598d54cb747368e000001a9-1477233631.185457-685691936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 12:03:03.941991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 12:03:03.942566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 12:03:03.943055) ========= ========= Total master_lag: 0.17 =========