builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1476045190.35 results: success (0) buildid: 20161009120418 builduid: de130ea26c6a42cfbade47182c7ce474 revision: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.349179) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.349723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.349995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.407306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.407589) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-09 13:33:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.4M=0s 2016-10-09 13:33:11 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080267 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.515059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.515328) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018842 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:10.579193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-09 13:33:10.579509) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa --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 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa --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=8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-09 13:33:11,243 truncating revision to first 12 chars 2016-10-09 13:33:11,243 Setting DEBUG logging. 2016-10-09 13:33:11,243 attempt 1/10 2016-10-09 13:33:11,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ba0016683ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-09 13:33:12,021 unpacking tar archive at: mozilla-central-0ba0016683ae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078246 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-09 13:33:11.672833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:11.673121) ========= script_repo_revision: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:11.673485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:11.673752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 13:33:11.684076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-09 13:33:11.684350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:33:12 INFO - MultiFileLogger online at 20161009 13:33:12 in /builds/slave/test 13:33:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:33:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:33:12 INFO - {'append_to_log': False, 13:33:12 INFO - 'base_work_dir': '/builds/slave/test', 13:33:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:33:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:33:12 INFO - 'branch': 'Firefox-Non-PGO', 13:33:12 INFO - 'buildbot_json_path': 'buildprops.json', 13:33:12 INFO - 'config_files': ('talos/linux_config.py',), 13:33:12 INFO - 'default_actions': ('clobber', 13:33:12 INFO - 'read-buildbot-config', 13:33:12 INFO - 'download-and-extract', 13:33:12 INFO - 'populate-webroot', 13:33:12 INFO - 'create-virtualenv', 13:33:12 INFO - 'install', 13:33:12 INFO - 'run-tests'), 13:33:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:33:12 INFO - 'download_minidump_stackwalk': True, 13:33:12 INFO - 'download_symbols': 'ondemand', 13:33:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:33:12 INFO - 'tooltool.py': '/tools/tooltool.py', 13:33:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:33:12 INFO - '/tools/misc-python/virtualenv.py')}, 13:33:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:33:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:33:12 INFO - 'installer_path': 'installer.exe', 13:33:12 INFO - 'log_level': 'info', 13:33:12 INFO - 'log_name': 'talos', 13:33:12 INFO - 'log_to_console': True, 13:33:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:33:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:33:12 INFO - 'opt_config_files': (), 13:33:12 INFO - 'pip_index': False, 13:33:12 INFO - 'sps_profile': False, 13:33:12 INFO - 'sps_profile_interval': 0, 13:33:12 INFO - 'suite': 'dromaeojs', 13:33:12 INFO - 'system_bits': '32', 13:33:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:33:12 INFO - 'title': 'talos-linux64-ix-001', 13:33:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:33:12 INFO - 'use_talos_json': True, 13:33:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:33:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:33:12 INFO - 'work_dir': 'build'} 13:33:12 INFO - [mozharness: 2016-10-09 20:33:12.453528Z] Running clobber step. 13:33:12 INFO - Running pre-action listener: _resource_record_pre_action 13:33:12 INFO - Running main action method: clobber 13:33:12 INFO - rmtree: /builds/slave/test/build 13:33:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:33:12 INFO - Running post-action listener: _resource_record_post_action 13:33:12 INFO - [mozharness: 2016-10-09 20:33:12.910543Z] Finished clobber step (success) 13:33:12 INFO - [mozharness: 2016-10-09 20:33:12.910644Z] Running read-buildbot-config step. 13:33:12 INFO - Running pre-action listener: _resource_record_pre_action 13:33:12 INFO - Running main action method: read_buildbot_config 13:33:12 INFO - Using buildbot properties: 13:33:12 INFO - { 13:33:12 INFO - "project": "", 13:33:12 INFO - "product": "firefox", 13:33:12 INFO - "script_repo_revision": "production", 13:33:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:33:12 INFO - "repository": "", 13:33:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:33:12 INFO - "buildid": "20161009120418", 13:33:12 INFO - "pgo_build": "False", 13:33:12 INFO - "basedir": "/builds/slave/test", 13:33:12 INFO - "buildnumber": 775, 13:33:12 INFO - "slavename": "talos-linux64-ix-001", 13:33:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:33:12 INFO - "platform": "ubuntu64_hw", 13:33:12 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:33:12 INFO - "branch": "mozilla-central", 13:33:12 INFO - "repo_path": "mozilla-central", 13:33:12 INFO - "revision": "0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa", 13:33:12 INFO - "stage_platform": "linux64", 13:33:12 INFO - "builduid": "de130ea26c6a42cfbade47182c7ce474", 13:33:12 INFO - "slavebuilddir": "test" 13:33:12 INFO - } 13:33:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:33:12 INFO - Running post-action listener: _resource_record_post_action 13:33:12 INFO - [mozharness: 2016-10-09 20:33:12.913061Z] Finished read-buildbot-config step (success) 13:33:12 INFO - [mozharness: 2016-10-09 20:33:12.913149Z] Running download-and-extract step. 13:33:12 INFO - Running pre-action listener: _resource_record_pre_action 13:33:12 INFO - Running main action method: download_and_extract 13:33:12 INFO - mkdir: /builds/slave/test/build/tests 13:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:12 INFO - trying https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:33:12 INFO - Downloading https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/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 13:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/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 13:33:13 INFO - Downloaded 1361 bytes. 13:33:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:33:13 INFO - Using the following test package requirements: 13:33:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:33:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:33:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'jsshell-linux-x86_64.zip'], 13:33:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:33:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:33:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:33:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:33:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:33:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:33:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:33:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:33:13 INFO - Fetch https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:33:14 INFO - Http code: 200 13:33:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 13:33:14 INFO - x-amz-cf-id: dQfs5z_Ek-67klt6IVp5krI8mSq4hP3qeb2Mc-0JONvJmyoLbhUhlg== 13:33:14 INFO - x-amz-version-id: pdTWyQ.uQ1DuBfBc75tw8XY2ZmvowhIa 13:33:14 INFO - Expected file size: 20516254 13:33:14 INFO - Obtained file size: 20516254 13:33:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:33:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:33:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:33:18 INFO - Fetch https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:33:19 INFO - Http code: 200 13:33:19 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 13:33:19 INFO - x-amz-cf-id: 5rh7ZWFtk5HLLJsfcHSS9LPt6UQ7Ryf_iDZaps43DLj6WisyCtINBw== 13:33:19 INFO - x-amz-version-id: pdTWyQ.uQ1DuBfBc75tw8XY2ZmvowhIa 13:33:19 INFO - Expected file size: 20516254 13:33:19 INFO - Obtained file size: 20516254 13:33:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:33:24 INFO - Fetch https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:33:24 INFO - Http code: 200 13:33:24 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 13:33:24 INFO - x-amz-cf-id: qTWlWuNY5WH2UfnRdkuNsY11eRFs8IUI6Vzivsxijdn_95UdOuKoeA== 13:33:24 INFO - x-amz-version-id: ulqwQkLCK2spaBTJt8rCmDnuQxsn5TTn 13:33:25 INFO - Expected file size: 14409006 13:33:25 INFO - Obtained file size: 14409006 13:33:26 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')]} 13:33:26 INFO - trying https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:33:26 INFO - Downloading https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/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 13:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/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 13:33:27 INFO - Downloaded 55826468 bytes. 13:33:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:33:27 INFO - mkdir: /builds/slave/test/properties 13:33:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:33:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:33:27 INFO - Contents: 13:33:27 INFO - build_url:https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:33:27 INFO - Running post-action listener: _resource_record_post_action 13:33:27 INFO - Running post-action listener: set_extra_try_arguments 13:33:27 INFO - [mozharness: 2016-10-09 20:33:27.965196Z] Finished download-and-extract step (success) 13:33:27 INFO - [mozharness: 2016-10-09 20:33:27.965421Z] Running populate-webroot step. 13:33:27 INFO - Running pre-action listener: _resource_record_pre_action 13:33:27 INFO - Running main action method: populate_webroot 13:33:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:27 INFO - '--tppagecycles', 13:33:27 INFO - '7'], 13:33:27 INFO - 'tests': ['tsvgm']}}, 13:33:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:33:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:33:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:33:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['damp', 'tps']}, 13:33:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'tests': ['damp', 'tps']}, 13:33:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['dromaeo_dom']}, 13:33:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['basic_compositor_video']}, 13:33:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:33:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['a11yr', 13:33:27 INFO - 'ts_paint', 13:33:27 INFO - 'tpaint', 13:33:27 INFO - 'sessionrestore', 13:33:27 INFO - 'sessionrestore_no_auto_restore', 13:33:27 INFO - 'tabpaint']}, 13:33:27 INFO - 'other-e10s': {'tests': ['a11yr', 13:33:27 INFO - 'ts_paint', 13:33:27 INFO - 'tpaint', 13:33:27 INFO - 'sessionrestore', 13:33:27 INFO - 'sessionrestore_no_auto_restore', 13:33:27 INFO - 'tabpaint']}, 13:33:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:33:27 INFO - 'ts_paint', 13:33:27 INFO - 'tpaint', 13:33:27 INFO - 'sessionrestore', 13:33:27 INFO - 'sessionrestore_no_auto_restore', 13:33:27 INFO - 'tabpaint']}, 13:33:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:33:27 INFO - 'ts_paint', 13:33:27 INFO - 'tpaint', 13:33:27 INFO - 'sessionrestore', 13:33:27 INFO - 'sessionrestore_no_auto_restore', 13:33:27 INFO - 'tabpaint']}, 13:33:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['a11yr', 13:33:27 INFO - 'ts_paint', 13:33:27 INFO - 'tpaint', 13:33:27 INFO - 'sessionrestore', 13:33:27 INFO - 'sessionrestore_no_auto_restore', 13:33:27 INFO - 'tabpaint']}, 13:33:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['a11yr', 13:33:27 INFO - 'ts_paint', 13:33:27 INFO - 'tpaint', 13:33:27 INFO - 'sessionrestore', 13:33:27 INFO - 'sessionrestore_no_auto_restore', 13:33:27 INFO - 'tabpaint']}, 13:33:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['tsvgx', 13:33:27 INFO - 'tsvgr_opacity', 13:33:27 INFO - 'tart', 13:33:27 INFO - 'tscrollx', 13:33:27 INFO - 'cart']}, 13:33:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:33:27 INFO - 'tsvgr_opacity', 13:33:27 INFO - 'tart', 13:33:27 INFO - 'tscrollx', 13:33:27 INFO - 'cart']}, 13:33:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'talos_options': ['--disable-e10s'], 13:33:27 INFO - 'tests': ['tp5o']}, 13:33:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'tests': ['tp5o']}, 13:33:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'talos_options': ['--disable-e10s', 13:33:27 INFO - '--xperf_path', 13:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:27 INFO - 'tests': ['tp5n']}, 13:33:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:27 INFO - 'talos_options': ['--xperf_path', 13:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:27 INFO - 'tests': ['tp5n']}}, 13:33:27 INFO - 'talos.zip': {'path': '', 13:33:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:27 INFO - Running post-action listener: _resource_record_post_action 13:33:27 INFO - [mozharness: 2016-10-09 20:33:27.981619Z] Finished populate-webroot step (success) 13:33:27 INFO - [mozharness: 2016-10-09 20:33:27.981708Z] Running create-virtualenv step. 13:33:27 INFO - Running pre-action listener: _resource_record_pre_action 13:33:27 INFO - Running main action method: create_virtualenv 13:33:27 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:33:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:28 INFO - Using real prefix '/usr' 13:33:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:28 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:30 INFO - Installing pip.................done. 13:33:30 INFO - Return code: 0 13:33:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:33:30 INFO - Reading from file tmpfile_stdout 13:33:30 INFO - Output received: 13:33:30 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) 13:33:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:33:30 INFO - Using env: {'DISPLAY': ':0', 13:33:30 INFO - 'HOME': '/home/cltbld', 13:33:30 INFO - 'LANG': 'en_US.UTF-8', 13:33:30 INFO - 'LANGUAGE': 'en_US:en', 13:33:30 INFO - 'LOGNAME': 'cltbld', 13:33:30 INFO - 'MAIL': '/var/mail/cltbld', 13:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:30 INFO - 'MOZ_NO_REMOTE': '1', 13:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:30 INFO - 'NO_EM_RESTART': '1', 13:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:30 INFO - 'PWD': '/builds/slave/test', 13:33:30 INFO - 'SHELL': '/bin/bash', 13:33:30 INFO - 'SHLVL': '1', 13:33:30 INFO - 'TERM': 'linux', 13:33:30 INFO - 'TMOUT': '86400', 13:33:30 INFO - 'USER': 'cltbld', 13:33:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:30 INFO - '_': '/tools/buildbot/bin/python'} 13:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:33:30 INFO - Cleaning up... 13:33:30 INFO - Return code: 0 13:33:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:33:30 INFO - Using env: {'DISPLAY': ':0', 13:33:30 INFO - 'HOME': '/home/cltbld', 13:33:30 INFO - 'LANG': 'en_US.UTF-8', 13:33:30 INFO - 'LANGUAGE': 'en_US:en', 13:33:30 INFO - 'LOGNAME': 'cltbld', 13:33:30 INFO - 'MAIL': '/var/mail/cltbld', 13:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:30 INFO - 'MOZ_NO_REMOTE': '1', 13:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:31 INFO - 'NO_EM_RESTART': '1', 13:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:31 INFO - 'PWD': '/builds/slave/test', 13:33:31 INFO - 'SHELL': '/bin/bash', 13:33:31 INFO - 'SHLVL': '1', 13:33:31 INFO - 'TERM': 'linux', 13:33:31 INFO - 'TMOUT': '86400', 13:33:31 INFO - 'USER': 'cltbld', 13:33:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:31 INFO - '_': '/tools/buildbot/bin/python'} 13:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:31 INFO - Downloading/unpacking psutil>=3.1.1 13:33:31 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 13:33:31 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 13:33:31 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 13:33:31 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 13:33:31 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 13:33:31 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 13:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:33 INFO - Installing collected packages: psutil 13:33:33 INFO - Running setup.py install for psutil 13:33:33 INFO - building 'psutil._psutil_linux' extension 13:33:33 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 13:33:33 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 13:33:33 INFO - building 'psutil._psutil_posix' extension 13:33:33 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 13:33:33 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 13:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:33 INFO - Successfully installed psutil 13:33:33 INFO - Cleaning up... 13:33:33 INFO - Return code: 0 13:33:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:33 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 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:33 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 13:33:33 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 13:33:33 INFO - Using env: {'DISPLAY': ':0', 13:33:33 INFO - 'HOME': '/home/cltbld', 13:33:33 INFO - 'LANG': 'en_US.UTF-8', 13:33:33 INFO - 'LANGUAGE': 'en_US:en', 13:33:33 INFO - 'LOGNAME': 'cltbld', 13:33:33 INFO - 'MAIL': '/var/mail/cltbld', 13:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:33 INFO - 'MOZ_NO_REMOTE': '1', 13:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:33 INFO - 'NO_EM_RESTART': '1', 13:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:33 INFO - 'PWD': '/builds/slave/test', 13:33:33 INFO - 'SHELL': '/bin/bash', 13:33:33 INFO - 'SHLVL': '1', 13:33:33 INFO - 'TERM': 'linux', 13:33:33 INFO - 'TMOUT': '86400', 13:33:33 INFO - 'USER': 'cltbld', 13:33:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:33 INFO - '_': '/tools/buildbot/bin/python'} 13:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:33:35 INFO - Installing collected packages: mozsystemmonitor 13:33:35 INFO - Running setup.py install for mozsystemmonitor 13:33:36 INFO - Successfully installed mozsystemmonitor 13:33:36 INFO - Cleaning up... 13:33:36 INFO - Return code: 0 13:33:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:33:36 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')]} 13:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:36 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')]} 13:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:36 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 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:36 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 13:33:36 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 13:33:36 INFO - Using env: {'DISPLAY': ':0', 13:33:36 INFO - 'HOME': '/home/cltbld', 13:33:36 INFO - 'LANG': 'en_US.UTF-8', 13:33:36 INFO - 'LANGUAGE': 'en_US:en', 13:33:36 INFO - 'LOGNAME': 'cltbld', 13:33:36 INFO - 'MAIL': '/var/mail/cltbld', 13:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:36 INFO - 'MOZ_NO_REMOTE': '1', 13:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:36 INFO - 'NO_EM_RESTART': '1', 13:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:36 INFO - 'PWD': '/builds/slave/test', 13:33:36 INFO - 'SHELL': '/bin/bash', 13:33:36 INFO - 'SHLVL': '1', 13:33:36 INFO - 'TERM': 'linux', 13:33:36 INFO - 'TMOUT': '86400', 13:33:36 INFO - 'USER': 'cltbld', 13:33:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:36 INFO - '_': '/tools/buildbot/bin/python'} 13:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:36 INFO - Downloading/unpacking jsonschema==2.5.1 13:33:36 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 13:33:36 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 13:33:36 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 13:33:36 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 13:33:36 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 13:33:36 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 13:33:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:33:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:38 INFO - Downloading functools32-3.2.3-2.tar.gz 13:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:33:38 INFO - warning: no files found matching '*.txt' 13:33:38 INFO - no previously-included directories found matching 'build' 13:33:38 INFO - no previously-included directories found matching 'dist' 13:33:38 INFO - no previously-included directories found matching '.git*' 13:33:38 INFO - Installing collected packages: jsonschema, functools32 13:33:38 INFO - Running setup.py install for functools32 13:33:38 INFO - warning: no files found matching '*.txt' 13:33:38 INFO - no previously-included directories found matching 'build' 13:33:38 INFO - no previously-included directories found matching 'dist' 13:33:38 INFO - no previously-included directories found matching '.git*' 13:33:38 INFO - Successfully installed jsonschema functools32 13:33:38 INFO - Cleaning up... 13:33:38 INFO - Return code: 0 13:33:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:33:38 INFO - Using env: {'DISPLAY': ':0', 13:33:38 INFO - 'HOME': '/home/cltbld', 13:33:38 INFO - 'LANG': 'en_US.UTF-8', 13:33:38 INFO - 'LANGUAGE': 'en_US:en', 13:33:38 INFO - 'LOGNAME': 'cltbld', 13:33:38 INFO - 'MAIL': '/var/mail/cltbld', 13:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:38 INFO - 'MOZ_NO_REMOTE': '1', 13:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:38 INFO - 'NO_EM_RESTART': '1', 13:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:38 INFO - 'PWD': '/builds/slave/test', 13:33:38 INFO - 'SHELL': '/bin/bash', 13:33:38 INFO - 'SHLVL': '1', 13:33:38 INFO - 'TERM': 'linux', 13:33:38 INFO - 'TMOUT': '86400', 13:33:38 INFO - 'USER': 'cltbld', 13:33:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:38 INFO - '_': '/tools/buildbot/bin/python'} 13:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:33:38 INFO - Cleaning up... 13:33:38 INFO - Return code: 0 13:33:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:33:38 INFO - Using env: {'DISPLAY': ':0', 13:33:38 INFO - 'HOME': '/home/cltbld', 13:33:38 INFO - 'LANG': 'en_US.UTF-8', 13:33:38 INFO - 'LANGUAGE': 'en_US:en', 13:33:38 INFO - 'LOGNAME': 'cltbld', 13:33:38 INFO - 'MAIL': '/var/mail/cltbld', 13:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:38 INFO - 'MOZ_NO_REMOTE': '1', 13:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:38 INFO - 'NO_EM_RESTART': '1', 13:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:38 INFO - 'PWD': '/builds/slave/test', 13:33:38 INFO - 'SHELL': '/bin/bash', 13:33:38 INFO - 'SHLVL': '1', 13:33:38 INFO - 'TERM': 'linux', 13:33:38 INFO - 'TMOUT': '86400', 13:33:38 INFO - 'USER': 'cltbld', 13:33:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:38 INFO - '_': '/tools/buildbot/bin/python'} 13:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:39 INFO - Downloading/unpacking blobuploader==1.2.4 13:33:39 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 13:33:39 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 13:33:39 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 13:33:39 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 13:33:39 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 13:33:39 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 13:33:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:33:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:33:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:41 INFO - Downloading docopt-0.6.1.tar.gz 13:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:33:41 INFO - Installing collected packages: blobuploader, requests, docopt 13:33:41 INFO - Running setup.py install for blobuploader 13:33:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:33:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:33:41 INFO - Running setup.py install for requests 13:33:42 INFO - Running setup.py install for docopt 13:33:42 INFO - Successfully installed blobuploader requests docopt 13:33:42 INFO - Cleaning up... 13:33:42 INFO - Return code: 0 13:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:42 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 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:42 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 13:33:42 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 13:33:42 INFO - Using env: {'DISPLAY': ':0', 13:33:42 INFO - 'HOME': '/home/cltbld', 13:33:42 INFO - 'LANG': 'en_US.UTF-8', 13:33:42 INFO - 'LANGUAGE': 'en_US:en', 13:33:42 INFO - 'LOGNAME': 'cltbld', 13:33:42 INFO - 'MAIL': '/var/mail/cltbld', 13:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:42 INFO - 'MOZ_NO_REMOTE': '1', 13:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:42 INFO - 'NO_EM_RESTART': '1', 13:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:42 INFO - 'PWD': '/builds/slave/test', 13:33:42 INFO - 'SHELL': '/bin/bash', 13:33:42 INFO - 'SHLVL': '1', 13:33:42 INFO - 'TERM': 'linux', 13:33:42 INFO - 'TMOUT': '86400', 13:33:42 INFO - 'USER': 'cltbld', 13:33:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:42 INFO - '_': '/tools/buildbot/bin/python'} 13:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:42 INFO - Running setup.py (path:/tmp/pip-CffKqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:42 INFO - Running setup.py (path:/tmp/pip-RNpHZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:42 INFO - Running setup.py (path:/tmp/pip-JGanzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:42 INFO - Running setup.py (path:/tmp/pip-lJMHCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:42 INFO - Running setup.py (path:/tmp/pip-51Sm4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:43 INFO - Running setup.py (path:/tmp/pip-2nm8Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:43 INFO - Running setup.py (path:/tmp/pip-7P0qfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:43 INFO - Running setup.py (path:/tmp/pip-A5unAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:43 INFO - Running setup.py (path:/tmp/pip-M0sIvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:43 INFO - Running setup.py (path:/tmp/pip-z7nhnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:43 INFO - Running setup.py (path:/tmp/pip-v76L97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:43 INFO - Running setup.py (path:/tmp/pip-PRujCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:43 INFO - Running setup.py (path:/tmp/pip-N_q6mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:43 INFO - Running setup.py (path:/tmp/pip-LwNz00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:43 INFO - Running setup.py (path:/tmp/pip-mx5fNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:43 INFO - Running setup.py (path:/tmp/pip-SzOQRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:43 INFO - Running setup.py (path:/tmp/pip-3eCoN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:33:43 INFO - Running setup.py install for manifestparser 13:33:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Running setup.py install for mozcrash 13:33:44 INFO - Running setup.py install for mozdebug 13:33:44 INFO - Running setup.py install for mozdevice 13:33:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Running setup.py install for mozfile 13:33:44 INFO - Running setup.py install for mozhttpd 13:33:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Running setup.py install for mozinfo 13:33:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Running setup.py install for mozInstall 13:33:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Running setup.py install for mozleak 13:33:44 INFO - Running setup.py install for mozlog 13:33:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Running setup.py install for moznetwork 13:33:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:33:45 INFO - Running setup.py install for mozprocess 13:33:45 INFO - Running setup.py install for mozprofile 13:33:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:33:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:33:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:33:45 INFO - Running setup.py install for mozrunner 13:33:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:33:45 INFO - Running setup.py install for mozscreenshot 13:33:45 INFO - Running setup.py install for moztest 13:33:45 INFO - Running setup.py install for mozversion 13:33:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:33:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:33:45 INFO - Cleaning up... 13:33:45 INFO - Return code: 0 13:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:33:45 INFO - Using env: {'DISPLAY': ':0', 13:33:45 INFO - 'HOME': '/home/cltbld', 13:33:45 INFO - 'LANG': 'en_US.UTF-8', 13:33:45 INFO - 'LANGUAGE': 'en_US:en', 13:33:45 INFO - 'LOGNAME': 'cltbld', 13:33:45 INFO - 'MAIL': '/var/mail/cltbld', 13:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:45 INFO - 'MOZ_NO_REMOTE': '1', 13:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:45 INFO - 'NO_EM_RESTART': '1', 13:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:45 INFO - 'PWD': '/builds/slave/test', 13:33:45 INFO - 'SHELL': '/bin/bash', 13:33:45 INFO - 'SHLVL': '1', 13:33:45 INFO - 'TERM': 'linux', 13:33:45 INFO - 'TMOUT': '86400', 13:33:45 INFO - 'USER': 'cltbld', 13:33:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:45 INFO - '_': '/tools/buildbot/bin/python'} 13:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:45 INFO - Running setup.py (path:/tmp/pip-xDoOaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:46 INFO - Running setup.py (path:/tmp/pip-ADMvso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:46 INFO - Running setup.py (path:/tmp/pip-T91PEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:46 INFO - Running setup.py (path:/tmp/pip-Cqsjft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:46 INFO - Running setup.py (path:/tmp/pip-MCbRKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:46 INFO - Running setup.py (path:/tmp/pip-TJqK2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:46 INFO - Running setup.py (path:/tmp/pip-pDwpRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:46 INFO - Running setup.py (path:/tmp/pip-TVrOMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:46 INFO - Running setup.py (path:/tmp/pip-yLweIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:46 INFO - Running setup.py (path:/tmp/pip-bWaZAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:46 INFO - Running setup.py (path:/tmp/pip-rPNuhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:46 INFO - Running setup.py (path:/tmp/pip-Ca0u7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:46 INFO - Running setup.py (path:/tmp/pip-JjXbCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:46 INFO - Running setup.py (path:/tmp/pip-hfelNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:46 INFO - Running setup.py (path:/tmp/pip-zVFNXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:47 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)) 13:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:47 INFO - Running setup.py (path:/tmp/pip-MQdanm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:47 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)) 13:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:47 INFO - Running setup.py (path:/tmp/pip-5I3Xi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:47 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)) 13:33:47 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)) 13:33:47 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)) 13:33:47 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)) 13:33:47 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)) 13:33:47 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)) 13:33:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:47 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 13:33:47 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 13:33:47 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 13:33:47 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 13:33:47 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 13:33:47 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 13:33:49 INFO - Downloading blessings-1.6.tar.gz 13:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:33:49 INFO - Installing collected packages: blessings 13:33:49 INFO - Running setup.py install for blessings 13:33:49 INFO - Successfully installed blessings 13:33:49 INFO - Cleaning up... 13:33:49 INFO - Return code: 0 13:33:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:49 INFO - Reading from file tmpfile_stdout 13:33:49 INFO - Current package versions: 13:33:49 INFO - argparse == 1.2.1 13:33:49 INFO - blessings == 1.6 13:33:49 INFO - blobuploader == 1.2.4 13:33:49 INFO - docopt == 0.6.1 13:33:49 INFO - functools32 == 3.2.3-2 13:33:49 INFO - jsonschema == 2.5.1 13:33:49 INFO - manifestparser == 1.1 13:33:49 INFO - mozInstall == 1.12 13:33:49 INFO - mozcrash == 0.17 13:33:49 INFO - mozdebug == 0.1 13:33:49 INFO - mozdevice == 0.48 13:33:49 INFO - mozfile == 1.2 13:33:49 INFO - mozhttpd == 0.7 13:33:49 INFO - mozinfo == 0.9 13:33:49 INFO - mozleak == 0.1 13:33:49 INFO - mozlog == 3.4 13:33:49 INFO - moznetwork == 0.27 13:33:49 INFO - mozprocess == 0.23 13:33:49 INFO - mozprofile == 0.28 13:33:49 INFO - mozrunner == 6.12 13:33:49 INFO - mozscreenshot == 0.1 13:33:49 INFO - mozsystemmonitor == 0.3 13:33:49 INFO - moztest == 0.7 13:33:49 INFO - mozversion == 1.4 13:33:49 INFO - psutil == 3.1.1 13:33:49 INFO - requests == 1.2.3 13:33:49 INFO - wsgiref == 0.1.2 13:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:49 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 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:49 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 13:33:49 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 13:33:49 INFO - Using env: {'DISPLAY': ':0', 13:33:49 INFO - 'HOME': '/home/cltbld', 13:33:49 INFO - 'LANG': 'en_US.UTF-8', 13:33:49 INFO - 'LANGUAGE': 'en_US:en', 13:33:49 INFO - 'LOGNAME': 'cltbld', 13:33:49 INFO - 'MAIL': '/var/mail/cltbld', 13:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:49 INFO - 'MOZ_NO_REMOTE': '1', 13:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:49 INFO - 'NO_EM_RESTART': '1', 13:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:49 INFO - 'PWD': '/builds/slave/test', 13:33:49 INFO - 'SHELL': '/bin/bash', 13:33:49 INFO - 'SHLVL': '1', 13:33:49 INFO - 'TERM': 'linux', 13:33:49 INFO - 'TMOUT': '86400', 13:33:49 INFO - 'USER': 'cltbld', 13:33:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:49 INFO - '_': '/tools/buildbot/bin/python'} 13:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:33:49 INFO - Cleaning up... 13:33:49 INFO - Return code: 0 13:33:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2422a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', '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 13:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:33:49 INFO - Using env: {'DISPLAY': ':0', 13:33:49 INFO - 'HOME': '/home/cltbld', 13:33:49 INFO - 'LANG': 'en_US.UTF-8', 13:33:49 INFO - 'LANGUAGE': 'en_US:en', 13:33:49 INFO - 'LOGNAME': 'cltbld', 13:33:49 INFO - 'MAIL': '/var/mail/cltbld', 13:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:49 INFO - 'MOZ_NO_REMOTE': '1', 13:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:49 INFO - 'NO_EM_RESTART': '1', 13:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:49 INFO - 'PWD': '/builds/slave/test', 13:33:49 INFO - 'SHELL': '/bin/bash', 13:33:49 INFO - 'SHLVL': '1', 13:33:49 INFO - 'TERM': 'linux', 13:33:49 INFO - 'TMOUT': '86400', 13:33:49 INFO - 'USER': 'cltbld', 13:33:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:49 INFO - '_': '/tools/buildbot/bin/python'} 13:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:33:49 INFO - Cleaning up... 13:33:49 INFO - Return code: 0 13:33:50 INFO - Running post-action listener: _resource_record_post_action 13:33:50 INFO - Running post-action listener: _start_resource_monitoring 13:33:50 INFO - Starting resource monitoring. 13:33:50 INFO - [mozharness: 2016-10-09 20:33:50.030665Z] Finished create-virtualenv step (success) 13:33:50 INFO - [mozharness: 2016-10-09 20:33:50.031135Z] Running install step. 13:33:50 INFO - Running pre-action listener: _resource_record_pre_action 13:33:50 INFO - Running main action method: install 13:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:50 INFO - Reading from file tmpfile_stdout 13:33:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:33:50 INFO - Reading from file tmpfile_stdout 13:33:50 INFO - Output received: 13:33:50 INFO - Usage: mozinstall [options] installer 13:33:50 INFO - Options: 13:33:50 INFO - -h, --help show this help message and exit 13:33:50 INFO - -d DEST, --destination=DEST 13:33:50 INFO - Directory to install application into. [default: 13:33:50 INFO - "/builds/slave/test"] 13:33:50 INFO - --app=APP Application being installed. [default: firefox] 13:33:50 INFO - mkdir: /builds/slave/test/build/application 13:33:50 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'] 13:33:50 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 13:34:06 INFO - Reading from file tmpfile_stdout 13:34:06 INFO - Output received: 13:34:06 INFO - /builds/slave/test/build/application/firefox/firefox 13:34:06 INFO - Running post-action listener: _resource_record_post_action 13:34:06 INFO - [mozharness: 2016-10-09 20:34:06.479197Z] Finished install step (success) 13:34:06 INFO - [mozharness: 2016-10-09 20:34:06.479442Z] Running run-tests step. 13:34:06 INFO - Running pre-action listener: _resource_record_pre_action 13:34:06 INFO - Running main action method: run_tests 13:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:34:06 INFO - Python 2.7.3 13:34:06 INFO - Return code: 0 13:34:06 INFO - grabbing minidump binary from tooltool 13:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dcf60>, '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 0x28ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:34:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:34:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:34:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:34:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:34:06 INFO - Return code: 0 13:34:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:34:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:34:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:34:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:34:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:34:06 INFO - Using env: {'DISPLAY': ':0', 13:34:06 INFO - 'HOME': '/home/cltbld', 13:34:06 INFO - 'LANG': 'en_US.UTF-8', 13:34:06 INFO - 'LANGUAGE': 'en_US:en', 13:34:06 INFO - 'LOGNAME': 'cltbld', 13:34:06 INFO - 'MAIL': '/var/mail/cltbld', 13:34:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:34:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:06 INFO - 'MOZ_NO_REMOTE': '1', 13:34:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:06 INFO - 'NO_EM_RESTART': '1', 13:34:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:06 INFO - 'PWD': '/builds/slave/test', 13:34:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:34:06 INFO - 'SHELL': '/bin/bash', 13:34:06 INFO - 'SHLVL': '1', 13:34:06 INFO - 'TERM': 'linux', 13:34:06 INFO - 'TMOUT': '86400', 13:34:06 INFO - 'USER': 'cltbld', 13:34:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534', 13:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:06 INFO - '_': '/tools/buildbot/bin/python'} 13:34:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:34:06 INFO - mozversion application_buildid: 20161009120418 13:34:06 INFO - mozversion application_changeset: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa 13:34:06 INFO - mozversion application_display_name: Nightly 13:34:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:34:06 INFO - mozversion application_name: Firefox 13:34:06 INFO - mozversion application_remotingname: firefox 13:34:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:34:06 INFO - mozversion application_vendor: Mozilla 13:34:06 INFO - mozversion application_version: 52.0a1 13:34:06 INFO - mozversion platform_buildid: 20161009120418 13:34:06 INFO - mozversion platform_changeset: 0ba0016683aef98cd7a64ff5e31f23e8d7eb08aa 13:34:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:34:06 INFO - mozversion platform_version: 52.0a1 13:34:06 INFO - using testdate: 1476045246 13:34:06 INFO - actual date: 1476045246 13:34:06 INFO - starting webserver on 'localhost:37266' 13:34:06 INFO - SUITE-START | Running 2 tests 13:34:06 INFO - TEST-START | dromaeo_css 13:34:06 INFO - operating with platform_type : linux_ 13:34:06 INFO - Initialising browser for dromaeo_css test... 13:34:06 INFO - TEST-INFO | started process 9966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsk_uVD/profile http://localhost:37266/getInfo.html) 13:34:11 INFO - PROCESS | 9966 | __metrics Screen width/height:1600/1200 13:34:11 INFO - PROCESS | 9966 | colorDepth:24 13:34:11 INFO - PROCESS | 9966 | Browser inner width/height: 1024/697 13:34:11 INFO - PROCESS | 9966 | __metrics 13:34:12 INFO - PROCESS | 9966 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:34:12 INFO - PROCESS | 9966 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:34:12 INFO - PROCESS | 9966 | console.error: PushService: 13:34:12 INFO - PROCESS | 9966 | stateChangeProcessEnqueue: Error transitioning state 13:34:12 INFO - PROCESS | 9966 | UnknownError 13:34:13 INFO - TEST-INFO | 9966: exit 0 13:34:13 INFO - Browser initialized. 13:34:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:34:13 INFO - TEST-INFO | started process 10050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsk_uVD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:25 INFO - PROCESS | 10050 | RSS: Main: 174186496 13:34:25 INFO - PROCESS | 10050 | 13:35:17 INFO - PROCESS | 10050 | 1476045317284 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] 13:37:30 INFO - PROCESS | 10050 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37266/tests/dromaeo/cssquery-ext.html) 13:37:31 INFO - PROCESS | 10050 | RSS: Main: 297934848 13:37:31 INFO - PROCESS | 10050 | 13:40:34 INFO - PROCESS | 10050 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-ext.html (next: http://localhost:37266/tests/dromaeo/cssquery-jquery.html) 13:40:35 INFO - PROCESS | 10050 | RSS: Main: 276881408 13:40:35 INFO - PROCESS | 10050 | 13:43:37 INFO - PROCESS | 10050 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37266/tests/dromaeo/cssquery-mootools.html) 13:43:38 INFO - PROCESS | 10050 | RSS: Main: 218857472 13:43:38 INFO - PROCESS | 10050 | 13:46:40 INFO - PROCESS | 10050 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37266/tests/dromaeo/cssquery-prototype.html) 13:46:40 INFO - PROCESS | 10050 | RSS: Main: 219582464 13:46:40 INFO - PROCESS | 10050 | 13:49:43 INFO - PROCESS | 10050 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37266/tests/dromaeo/cssquery-yui.html) 13:49:44 INFO - PROCESS | 10050 | RSS: Main: 223485952 13:49:44 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-yui.html (next: http://localhost:37266/tests/dromaeo/cssquery-dojo.html) 13:52:47 INFO - PROCESS | 10050 | RSS: Main: 314519552 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | __start_tp_report 13:52:47 INFO - PROCESS | 10050 | _x_x_mozilla_page_load 13:52:47 INFO - PROCESS | 10050 | _x_x_mozilla_page_load_details 13:52:47 INFO - PROCESS | 10050 | |i|pagename|runs| 13:52:47 INFO - PROCESS | 10050 | |0;dojo.html;2558.897644094236;2594.377349436136;2625.842449453033;2640.4983053219885;2651.0853755454373;4569.862904112873;4618.676692631517;4724.503927087653;4734.763261836907;4749.762511874401;4656.41794775653;4663.370444989925;4699.976500117503;4743.146233677937;4745.311929770181;4241.4698162729655;4242.745435273878;4297.35539669049;4317;4358.97820510897;4053.2298863215897;4358.193734159191;4367.672424568154;4397.802098905557;4445.533219012005;4255.659547236244;4348.673849461272;4393.143337049277;4456.532064133268;4506.707064040843;4271.67962402821;4317.589828966243;4336.761478118702;4342.630876375511;4353.434053573047;4338.2191205582985;4343.109662519208;4386.649068074546;4395.318725597537;4405.867823965286;4654.790534425959;4676.906461870778;4693.671442998992;4717.646176536773;4770.379850619432;4876.853694389174;4884.267359896008;4916;5045.621578381636;5047.596192304607;5003.099442100421;5018.146915024455;5026.1204289249235;5047.697138171721;5077.64456488046;4674.719516829001;4680.485146633936;4680.95319046812;4682;4737.2183589708;4901.485344038896;4936.975315123474;5104.464031276662;5108.565771909355;5162.483751624883;4873.829415970424;4889.828855990023;4897.583705385011;4922.827701030446;4967.081089998362;4940.530649588283;4951.529604687549;5024.095662780662;5028;5099.821506247264;4816.229403295456;4853.878653033632;4977.377827771528;4989.376327959005;4991.700497970133;4922.630802689812;4972.925406118911;4974.8756281093265;4975.10448119342;4990.675606085593;4319.697621166488;4324.394584758136;4332.285172946492;4389.890252743643;4390.714603550759;3703.092742278105;3717.2379662169733;3765.3787125124595;3777.320082385197;3843.1160833008566;4274.529801721808;4280.871573852789;4294.699371044059;4308.676849236257;4381.3208952612395;5039.168537191323;5075.543201111844;5080.26336181259;5080.720560369141;5144.099782538041;4317.222899878052;4324.740515569076;4327.7619730914475;4331.5884990925815;4381.759003254788;4440.289553671397;4492.326151077365;4492.618127459203;4554.066416384633;4603.631709463235;4783.473817879961;4824.927626085611;4828.444728856086;4837.7097374157665;4839.080574690797;5083.2883396323805;5084.466131056186;5084.542391184811;5091.389033316026;5140.254663073908;4593.26507758757;4759.809607615656;4776.617870570415;4777.211760059551;4826.107170173529;4795.784189711541;4808.927866081942;4833.540813622701;4858;4891.437484689306;4860.392450943632;4899.461059283405;4905;4911;4969.428515720739;4742.383490146259;4785.712857228438;4789.066132104206;4789.568938795525;4847.491013443679;4781.306710526885;4828.565429111397;4868.805247790048;4923.950760492349;4926.48271931442;4863.586595139312;4866.829660961849;4869.780859861244;4926.655134140576;4933.062718083553;4972.676776009548;4973.502649734997;4975.278584605285;4975.378077740283;4975.452700203047;4702.824293926518;4725.432948046119;4747.074320507468;4773.021530586291;4911.901761964669 13:52:47 INFO - PROCESS | 10050 | |1;ext.html;537.69620164607;548.8024311247952;558.7904535799075;570.7060863655219;573.2977103048765;26765.197044088683;36217.45673814892;37211.4418283726;37245.62754372456;41848.58151418485;38321.425178622274;38437.807810960905;38442.615573844254;38483.422748658726;38549.80725096378;7599.430042746802;7749.535027898316;7754.379649628045;7758.340541054017;7759.495632783851;7360.07999000125;7444.925550744504;7450.8137296567475;7453.068366454193;7455.664495097733;7450.478466507347;7480.62596870157;7488.32605065544;7497.025386699722;7498.462815122887;7423.109226892753;7449.664765085584;7451.068616422947;7460.328570428634;7462.85074298511;7529.9247007529775;7613.467057305991;7614.428917831185;7615.847683046363;7620.580868052255;36280;36725.081872953124;36738;36851.81574092139;36892.81553592215;3034.8179109253297;3043.9695603043906;3080.122165182912;3264.6898544638457;3594.029612004744;27622.723772762216;27894;28371.85814070937;28378.85810570934;28918.132456026142;3401.234722187513;3455.2571197192474;3465.9653403466145;3501.107217659506;3510.1224693826543;244499;244742;245122.7743861287;245491;246367;30535.541966870514;49660.25509617358;49903;49951.75024124929;50067;31103.377932441224;33078.3384332312;33175.502367464505;33242.66757332395;33276.83361583177;12281.815772763415;12312.199707019015;12312.692182695326;12340.50637974489;12343.938280308541;10509.527071281811;10510.054095131474;10525.315854469434;10530.10494107994;10543.57825686964;7729.5748733819055;7770.057485628593;7858.803529911798;7896.368290536743;7921.960390198012;3046.9238269043008;3046.9238269043453;3118.469860123784;3131.185891668137;3146.0404576604355;799.4403917257943;868.8305780372893;882.6910581296495;921.3918813583003;972.2173650211647;25059.373515662253;26704.931802727675;26799.19602411931;27091.729082709317;27302.863485682443;741.9146798118286;961.7932144588807;987.6592575561419;999.480270259461;1027.1833892055834;13898.374573144232;13975.440982360795;14296.642583935276;14308.928455357656;14363.353649085817;357987;360193;360220;360439;360694;46791;47261.29108063382;47268.7636561815;47296.763516182196;47302.5269747305;1053.210092430677;1086.413336798136;1086.6631344283298;1164.7903377392151;1194.510250797169;23403.531929360975;27487.17538473849;28526.85736571304;30569.388612228075;30670.84664576663;43987.78006109949;44846.77576612096;44855.551444485136;44879;44896;321647;324837;325256;325341;325428;21635.459113522287;21941.476730176233;22090.77909220887;24270.87864560666;24710.629340560266;39493.80253098716;39656.60343396645;39712.60287397089;39926.00184995282;39995.80002099971;33710;34234.315313693085;34505.48241776426;34919.301613968084;34964.82517587396;33384.33231335311;33812.323753525285;33932.830335848164;34141;34874.82562587171;33626.159346016546;33963.66036339704;34168.31663366769;34360.48459273163;34396;28926.409047502588;31106.688933110378;31403.68596314099;31405;31636.841815790773;23914.760852391253;23969.880150599136;23975.76024239735;24393.878030609732;24665.260042198763 13:52:47 INFO - PROCESS | 10050 | |2;jquery.html;328.90461766087833;329.50080627848814;347.64540169027595;347.885197884698;371.7973704331141;12026.338551379671;13044.60866174015;15274.92362538187;15506.61233469161;16363;16318.918405407956;16470.258838352274;16474;16489.257983390748;16752.329906803712;3940.8965489662796;4809.182438985381;5027.145385284511;5032.11937910866;5032.547070763649;4857.441394239655;4936.407631084275;4946.060248552782;4946.604271658259;4947.257911313314;4869;4869.196582563891;4870.147724148278;4871.8782030449165;4876;4878.756062196876;5148.253503242027;5178.5857131429775;5271.28837606922;5284.128118860383;4890.853274401774;5129.1024070787835;5134.0758663440565;5139.614528910347;5140.614453915971;11470.827937580943;11820.940895295469;11833.349165795878;11835.704107397298;11837.467313970892;1868.8037756035692;1886.6604011277964;1889.310401703382;1894.8673592848506;1934.2456441987636;8625.956870215672;8630.741077767614;8803.955980220122;9061.456312621263;9326.02076781935;1606.702759989394;1635.6319828038716;1650.4306014425124;1747.7075588599753;1786.606946471774;64439;64672.3532764671;66360.66819665919;67080.99378509278;67897.32102679009;8253.298469630028;8506.959194382742;8954.373193876496;8963.775905602282;10052.145567626834;11679;11704.122190835722;11793.233439826385;11794.823077653842;11805.055595552507;7102.218755936843;7107.71569137239;7248.782536523912;7319.74380896666;7361.595112268877;6624.327115439325;6786.321367863175;6883.036374907517;7014.070704921002;7124.287571242834;3699.8520059197867;3723.162288485069;3745.7003439725304;3788.090858194069;3842.8462861485227;1737.1835237438384;1740.1473278093642;1778.199810085441;1851.3057603398724;1855.4526414707693;793.1394437035765;821.1665159862744;827.4993628854577;879.8812160358398;882.668999125328;15823.367065317258;16576.75134872978;17047.31810727557;17105.401310954057;17343.392981245597;836.4730219961507;844.9450785698909;894.7718331825342;902.9187373136318;910.7677542226822;9043.231325337289;9691.806163876823;9701.07839755222;9721.270904682036;9859.50702464874;263796;266141;355628;357211;360075;80804;81337.59331203306;81373.59313203396;82245.17754822495;82835.5858220717;886.2511178054533;902.0483390023588;924.1497822003772;927.758782716485;928.4707716601607;15418.46035388756;15424;16066.43767468133;16273.74525094962;16388.83611163873;35339.29321413609;35697.28605427929;35785.46321805227;36440.45339319859;36746.816265918496;47901.28148077851;50685.74657126691;50980;51370.22944655908;51983.74008129935;6883.518153729391;6957.060796792571;7053.1536215652395;7142.285771422816;7255.165655949633;6102.084687296941;8866.64533418656;9673.854892176763;10616.469176541297;10647.946760266459;8575.699850505202;9383.202427793714;9508.952455237679;9543.713688589354;9615.23078153732;9424.198943089914;9565.426074435556;9720.465374404193;9725.270604704534;9734.659286924923;9440;9578.56896439648;9663.178629816544;9972.152367048591;10086.092251697382;6393.6163830170335;7078.1506219254015;7669.846603068019;7694.422918281263;8036.959815200887;9019.458832470073;9461.952690236505;9555.665551705657;10504.632337868443;10597.62908298206 13:52:47 INFO - PROCESS | 10050 | |3;mootools.html;1209.9516019359226;1321.3195204469696;1360.6530334764634;1366.8564800695926;1618.9028658280497;6248.218972628421;7315.9634201828985;7509.924900750998;7533.510321829077;7785.41609379296;7572.772816815491;7662.808429789258;7663.118741344747;7668.884966725504;7686.730964416247;2024.7165396844453;2065.070718176819;2066.60734460452;2067.886266255355;2069.8758074515504;2104.4318034130774;2141.0365335598963;2150.311900191939;2150.3656421355736;2157.967630485544;2082.3138151784256;2090.770015298316;2102.5899949509853;2105.705201271823;2112.12346876047;2023.4435530229157;2031.695245713155;2039.5920815836819;2041.1529215375601;2042.4689580708973;1987.8210961013433;2013.1041686449537;2047.7337946066916;2047.938561843147;2048.4366799130207;7547.05661792276;7629.160792312841;7703.114141873701;7708.075030996316;7739.7678069658;4342.32693932441;4532.592066713979;4533.818647254106;4539.228331183706;4540.636749060101;2561.7694407503227;2664.4138289576263;2715.945681086387;2725.645666063399;2732.699403065661;850.2602735620051;856.1823458597025;862.7023676831483;868.9261412779921;880.3617377401333;10432.791344173074;10479.895201047968;10492.737681557946;10573.3127346723;10584.735381615521;3613.33153366628;3729.6083911188935;3789.4315852621776;3867.497225360685;3870.4000879863665;8119.269265766109;8128.268455839003;8148.796280093045;8150.38872084596;8154.469959452736;4383.868483945486;4384.101259241847;4391.802368893407;4392.143532011291;4396.978015109968;3341.131305860445;3444.190615205425;3968.6825053995613;4095.1400205957084;4113.03343714227;3277.655846136169;3285.490748933871;3384.2385463270566;3387.288669379458;3393.8472768725464;994.9005099489993;1012.2408193854609;1014.91373233276;1022.1720406470633;1032.200044965158;703.7818276334352;825.3026192867018;844.2317491083085;850.7702920211508;853.3642436384933;5093.923591146136;5145.099607568661;5196.220566914917;5299.655522391032;5377.274068000848;374.32247631786555;391.1707180776771;392.2997449552535;394.2076426382991;397.239286765846;3580.051286409104;3735.402335626287;3737.32728108943;3801.1067399161175;3812.8665496708036;8945.37382383227;9203.585838637277;9532;9578.701111733133;9620.90379096214;9378.109079637423;9507.952460237655;9508.381955172892;9508.857367139499;9534.666286679932;7025.754098606524;7051.858962820715;7063.646817659199;7184.9640751795905;7194.748183813542;5304.60215483848;5322.254884316276;5372.774822209688;5454.836354909359;5481.369642491165;8716.738497845075;8732.869006964773;8740.300775938036;8742.431741936754;8783.077776833596;8510.914890851012;8689.652413903374;8838.690645827364;8838.867416988622;8930.285577153682;6428.292887782247;7310.780676579711;7418.146913105062;7418.146913105062;7447.515911465737;6052.243469566304;7260.89108663381;7269.818254543678;7444.106707195171;7450.36671882896;6470.870582588228;6479.514036447191;6620.3710647488415;6664.300248474035;6717.529772915849;6614.404703576509;6641.867162656817;6674.299198584079;6678.666066696548;6764.0868482754195;6137.907931381123;6229.719662615284;6231.9688401557705;6242.938700420848;6244.250689917239;4410.603045725772;4499.30260809562;4540.545945405433;4597.7241365518175;4616.8614941551805;4503.414556107685;4515.887102822456;4622.537746225351;4637.953620463887;4715.292706094114 13:52:47 INFO - PROCESS | 10050 | |4;prototype.html;264.6876685511097;265.32342526557284;271.1445389795196;273.6784278472794;277.4589550376765;4869.68347057441;4895.21676531755;4896.314515967763;4907.7975895905465;4921.465445295671;4839.153148199069;4840.951590484094;4841.225403935371;4847.975760121203;4848.878778030551;3773.18876441565;3773.339665558516;3780.319542482352;3782.678472329855;3795.734298599099;3783.69730421567;3792.2506183017367;3796.2787070456525;3800.068983099131;3803.50554427924;3412.5904891412943;3657.9268414631692;3692.5568931728094;3747.718921080916;3759.9812000939955;3691.464737613058;3702.7963462009443;3704.4998925145164;3710.2579484103017;3710.8330125144435;3198.792078514889;3202.3115030268605;3205.8397080146133;3209.823459709715;3212.1969507623094;4488.259437192859;4585.541445855421;4625.190591646448;4721.26820342844;4735.905281894343;4191.476065491814;4195.098053918422;4197.91604167918;4201.848613539845;4207.506335251003;5061.16490779021;5063.11395505785;5067.695938243681;5075.238714192864;5076.949230507685;3209.871605135792;3221.6617255188103;3383.2556837495713;3384.3908096542614;3413.385590593692;5271.5782737381305;5284.682919024871;5291.894162116736;5293.126634105368;5295;3588.9102772430897;3595.3528364894046;3601.243738814826;3603.5855876574005;3605.9278814423565;3503.4219353806848;3608.986496275639;3631.364511210528;3642.1440961374055;3648.069742215771;4162.063535704442;4171.749695018309;4172.541020487804;4175.749455032707;4185.748855068706;5038.79844806211;5045.318881950963;5047.343845300161;5053.9241911371355;5066.16408292635;1216.1669256559107;1247.1457051919465;1249.8062800265973;1258.3829778734282;1261.7602655495427;774.8915151878741;788.1487992967582;792.6116203060574;795.316028215734;796.6536553225031;3927.489426374553;3934.685225182036;3957.9604203957592;3971.3050216212046;3978.42312864633;4568.543145685405;4603.401557797465;4604.217283061887;4610.2623580227;4611.400517932647;3823.502944617182;3883.5339759229073;3969.5511138434263;3975.7018223633345;3997.240524300432;2442.1330427698267;2455.8772061397217;2462.3351695042597;2469.9753002470106;2470.7152280813875;4282.421873047161;4285.442892423965;4312.5903039211225;4333;4633.212353899845;5187.507186817246;5224.817131400383;5331.600129990189;5383.43473935239;5387.164989426645;4907.337509436252;4909.214525675875;4910.312556242129;4914.459409465027;4918.188498897642;5045.445001049955;5200.401953775364;5254.633795213195;5261.553072904829;5267.89464210706;5078.822241221539;5107.336046313955;5121.590272778094;5124.897502050013;5143.871403214949;4831.255776773029;4847.151748444078;4902.142125128017;4905.2151655734915;4907.705537667752;3488.424409972326;3544.4328907374697;3585.659362360676;3595.6763891248866;3598.1184609770776;5161.277421160966;5195;5217.973910130577;5234.921476177937;5269.525742683177;5064.620153488429;5073.021521606503;5094.923576146435;5096.961215513824;5115.335006449138;4851.199552073868;5049.722265275298;5076.670016448919;5097.464766199496;5128.205128205134;5008.524190201925;5024.698518088926;5043.722595257296;5046.621503387334;5046.646734728681;5117.232415137759;5124.666896651705;5125.820596279113;5153.3558305211845;5162.922556161586;4878.463369029333;4936.8765780855765;4966.453690094159;5029.547340739351;5036.269740887477 13:52:47 INFO - PROCESS | 10050 | |5;yui.html;644.9484041276697;677.7458453080095;678.0236459498323;682.621145264378;683.8085336105889;13011.73976520469;13733.519326823563;14054.29728513574;14089.29553522325;14162.150270983722;13421.396037178327;13494.932525337359;13550.72898542031;13552.457901683945;13556.254406007665;602.1239097113711;619.1177571959962;738.951968122073;758.0145810446426;758.4956004257162;738.1584993107834;757.9393648508106;765.0666187251544;765.0704394161094;766.6205228411916;792.9722459713911;795.2326005404783;795.5107608820591;795.5465384730705;795.6976348987376;623.1369553168848;639.7249182851372;789.3645615279697;789.6288744290174;790.0637744273055;471.5143402295641;471.93156992236277;472.4094881398252;563.6336381352113;580.9506191973687;12563.623091307276;12566.30885301308;12602.621921342374;12693.238405695596;12693.873061269362;12508.74982500345;12834.422450989634;13182.34088295591;13192.142510736772;13418.731625367438;11521.284917860768;11603.825942610867;11782;11844.585439509576;12202.328871912041;4013.6588389986887;4063.7358571692744;4117.75293482392;4141.834326626931;4171.124063946575;60757.69621151866;61500.384996149915;61619.69190154065;61640.69179654118;61655.07517387243;10225.590976360862;10230;10357.689269321932;10413.42726150069;10541.104006159563;19233.90383048076;19380.903095484715;19391.612167756564;19434.5141371464;19449.708254376197;6755.695993680296;6773.051772751819;6944.305569443015;7039.577625342496;7197.748078817321;3687.59436461989;3709.1839795245005;3721.4603882436895;3722.3299806035175;3723.5345581802276;2681.9061332853257;2781.8330900146057;2810.086721815418;2811.8594070296404;2813.9296517587222;473.197929509485;476.22613253463123;482.6114977443122;496.2432290756625;500.6395395315367;456.80129143822546;504.6870940017213;508.55501436243287;560.1150182711307;563.4056070845215;7481.177070522238;7737.2262773723305;7757.72847950319;7788.415868809749;7792.181820908723;462.23961583195455;479.1853848457636;492.2468623006805;505.7243802127849;519.3326575350657;3625.728070394731;3722.088088418355;3826.579076301605;3916.243122609759;3970.6029397060065;94454;95109;96693;97399.51300243595;100292;44576.777116114215;80846;84158;85024.14975850286;89075.55462222647;41915.371269430376;42364.57635423668;48433;68822;70358.29641703518;8147.7816262577135;8364.874526882224;8444.831103378021;8482.109378515413;8618.482891026559;33176.17059573434;37517.43723844199;40275.59724402836;40428.722829889724;45007.099858002;45380.31929521126;49457.25814112863;64002.67998659977;70409;71870;11709.473073711533;12423.751524969632;12474.438650260941;12746.617601471971;12859.807102893277;13283.136596121221;13524.256165910969;13562.457501699822;13841.723165536432;14256.358463868943;12092.637220883387;12111.394430278628;12308.138430309793;13007.414666340226;13119.022184682115;12334;12751.872481275068;12784.360781961052;13037.804432933703;13102.344882756015;11499.655010349703;11840;12028.398580071136;12411.193272437262;13242.073054886065;10327.010437979152;10340.172786176938;10650.201234907569;11051.889481105087;11110.44447777624;10536.473176340998;10840.783184336427;11060.17048721333;11072.114230861673;11075.5569777208 13:52:47 INFO - PROCESS | 10050 | __end_tp_report 13:52:47 INFO - PROCESS | 10050 | __start_cc_report 13:52:47 INFO - PROCESS | 10050 | _x_x_mozilla_cycle_collect,1151 13:52:47 INFO - PROCESS | 10050 | __end_cc_report 13:52:47 INFO - PROCESS | 10050 | __startTimestamp1476046367760__endTimestamp 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | ------- Summary: start ------- 13:52:47 INFO - PROCESS | 10050 | Number of tests: 6 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | [#0] dojo.html Cycles:165 Average:4636.50 Median:4776.62 stddev:474.42 (9.9%) stddev-sans-first:447.01 13:52:47 INFO - PROCESS | 10050 | Values: 2558.9 2594.4 2625.8 2640.5 2651.1 4569.9 4618.7 4724.5 4734.8 4749.8 4656.4 4663.4 4700.0 4743.1 4745.3 4241.5 4242.7 4297.4 4317.0 4359.0 4053.2 4358.2 4367.7 4397.8 4445.5 4255.7 4348.7 4393.1 4456.5 4506.7 4271.7 4317.6 4336.8 4342.6 4353.4 4338.2 4343.1 4386.6 4395.3 4405.9 4654.8 4676.9 4693.7 4717.6 4770.4 4876.9 4884.3 4916.0 5045.6 5047.6 5003.1 5018.1 5026.1 5047.7 5077.6 4674.7 4680.5 4681.0 4682.0 4737.2 4901.5 4937.0 5104.5 5108.6 5162.5 4873.8 4889.8 4897.6 4922.8 4967.1 4940.5 4951.5 5024.1 5028.0 5099.8 4816.2 4853.9 4977.4 4989.4 4991.7 4922.6 4972.9 4974.9 4975.1 4990.7 4319.7 4324.4 4332.3 4389.9 4390.7 3703.1 3717.2 3765.4 3777.3 3843.1 4274.5 4280.9 4294.7 4308.7 4381.3 5039.2 5075.5 5080.3 5080.7 5144.1 4317.2 4324.7 4327.8 4331.6 4381.8 4440.3 4492.3 4492.6 4554.1 4603.6 4783.5 4824.9 4828.4 4837.7 4839.1 5083.3 5084.5 5084.5 5091.4 5140.3 4593.3 4759.8 4776.6 4777.2 4826.1 4795.8 4808.9 4833.5 4858.0 4891.4 4860.4 4899.5 4905.0 4911.0 4969.4 4742.4 4785.7 4789.1 4789.6 4847.5 4781.3 4828.6 4868.8 4924.0 4926.5 4863.6 4866.8 4869.8 4926.7 4933.1 4972.7 4973.5 4975.3 4975.4 4975.5 4702.8 4725.4 4747.1 4773.0 4911.9 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | [#1] ext.html Cycles:180 Average:44735.18 Median:3460.61 stddev:82701.59 (2389.8%) stddev-sans-first:82867.01 13:52:47 INFO - PROCESS | 10050 | Values: 537.7 548.8 558.8 570.7 573.3 26765.2 36217.5 37211.4 37245.6 41848.6 38321.4 38437.8 38442.6 38483.4 38549.8 7599.4 7749.5 7754.4 7758.3 7759.5 7360.1 7444.9 7450.8 7453.1 7455.7 7450.5 7480.6 7488.3 7497.0 7498.5 7423.1 7449.7 7451.1 7460.3 7462.9 7529.9 7613.5 7614.4 7615.8 7620.6 36280.0 36725.1 36738.0 36851.8 36892.8 3034.8 3044.0 3080.1 3264.7 3594.0 27622.7 27894.0 28371.9 28378.9 28918.1 3401.2 3455.3 3466.0 3501.1 3510.1 244499.0 244742.0 245122.8 245491.0 246367.0 30535.5 49660.3 49903.0 49951.8 50067.0 31103.4 33078.3 33175.5 33242.7 33276.8 12281.8 12312.2 12312.7 12340.5 12343.9 10509.5 10510.1 10525.3 10530.1 10543.6 7729.6 7770.1 7858.8 7896.4 7922.0 3046.9 3046.9 3118.5 3131.2 3146.0 799.4 868.8 882.7 921.4 972.2 25059.4 26704.9 26799.2 27091.7 27302.9 741.9 961.8 987.7 999.5 1027.2 13898.4 13975.4 14296.6 14308.9 14363.4 357987.0 360193.0 360220.0 360439.0 360694.0 46791.0 47261.3 47268.8 47296.8 47302.5 1053.2 1086.4 1086.7 1164.8 1194.5 23403.5 27487.2 28526.9 30569.4 30670.8 43987.8 44846.8 44855.6 44879.0 44896.0 321647.0 324837.0 325256.0 325341.0 325428.0 21635.5 21941.5 22090.8 24270.9 24710.6 39493.8 39656.6 39712.6 39926.0 39995.8 33710.0 34234.3 34505.5 34919.3 34964.8 33384.3 33812.3 33932.8 34141.0 34874.8 33626.2 33963.7 34168.3 34360.5 34396.0 28926.4 31106.7 31403.7 31405.0 31636.8 23914.8 23969.9 23975.8 24393.9 24665.3 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | [#2] jquery.html Cycles:180 Average:21742.69 Median:28054.55 stddev:54176.31 (193.1%) stddev-sans-first:54304.43 13:52:47 INFO - PROCESS | 10050 | Values: 328.9 329.5 347.6 347.9 371.8 12026.3 13044.6 15274.9 15506.6 16363.0 16318.9 16470.3 16474.0 16489.3 16752.3 3940.9 4809.2 5027.1 5032.1 5032.5 4857.4 4936.4 4946.1 4946.6 4947.3 4869.0 4869.2 4870.1 4871.9 4876.0 4878.8 5148.3 5178.6 5271.3 5284.1 4890.9 5129.1 5134.1 5139.6 5140.6 11470.8 11820.9 11833.3 11835.7 11837.5 1868.8 1886.7 1889.3 1894.9 1934.2 8626.0 8630.7 8804.0 9061.5 9326.0 1606.7 1635.6 1650.4 1747.7 1786.6 64439.0 64672.4 66360.7 67081.0 67897.3 8253.3 8507.0 8954.4 8963.8 10052.1 11679.0 11704.1 11793.2 11794.8 11805.1 7102.2 7107.7 7248.8 7319.7 7361.6 6624.3 6786.3 6883.0 7014.1 7124.3 3699.9 3723.2 3745.7 3788.1 3842.8 1737.2 1740.1 1778.2 1851.3 1855.5 793.1 821.2 827.5 879.9 882.7 15823.4 16576.8 17047.3 17105.4 17343.4 836.5 844.9 894.8 902.9 910.8 9043.2 9691.8 9701.1 9721.3 9859.5 263796.0 266141.0 355628.0 357211.0 360075.0 80804.0 81337.6 81373.6 82245.2 82835.6 886.3 902.0 924.1 927.8 928.5 15418.5 15424.0 16066.4 16273.7 16388.8 35339.3 35697.3 35785.5 36440.5 36746.8 47901.3 50685.7 50980.0 51370.2 51983.7 6883.5 6957.1 7053.2 7142.3 7255.2 6102.1 8866.6 9673.9 10616.5 10647.9 8575.7 9383.2 9509.0 9543.7 9615.2 9424.2 9565.4 9720.5 9725.3 9734.7 9440.0 9578.6 9663.2 9972.2 10086.1 6393.6 7078.2 7669.8 7694.4 8037.0 9019.5 9462.0 9555.7 10504.6 10597.6 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | [#3] mootools.html Cycles:180 Average:4980.02 Median:5170.66 stddev:2846.97 (55.1%) stddev-sans-first:2840.86 13:52:47 INFO - PROCESS | 10050 | Values: 1210.0 1321.3 1360.7 1366.9 1618.9 6248.2 7316.0 7509.9 7533.5 7785.4 7572.8 7662.8 7663.1 7668.9 7686.7 2024.7 2065.1 2066.6 2067.9 2069.9 2104.4 2141.0 2150.3 2150.4 2158.0 2082.3 2090.8 2102.6 2105.7 2112.1 2023.4 2031.7 2039.6 2041.2 2042.5 1987.8 2013.1 2047.7 2047.9 2048.4 7547.1 7629.2 7703.1 7708.1 7739.8 4342.3 4532.6 4533.8 4539.2 4540.6 2561.8 2664.4 2715.9 2725.6 2732.7 850.3 856.2 862.7 868.9 880.4 10432.8 10479.9 10492.7 10573.3 10584.7 3613.3 3729.6 3789.4 3867.5 3870.4 8119.3 8128.3 8148.8 8150.4 8154.5 4383.9 4384.1 4391.8 4392.1 4397.0 3341.1 3444.2 3968.7 4095.1 4113.0 3277.7 3285.5 3384.2 3387.3 3393.8 994.9 1012.2 1014.9 1022.2 1032.2 703.8 825.3 844.2 850.8 853.4 5093.9 5145.1 5196.2 5299.7 5377.3 374.3 391.2 392.3 394.2 397.2 3580.1 3735.4 3737.3 3801.1 3812.9 8945.4 9203.6 9532.0 9578.7 9620.9 9378.1 9508.0 9508.4 9508.9 9534.7 7025.8 7051.9 7063.6 7185.0 7194.7 5304.6 5322.3 5372.8 5454.8 5481.4 8716.7 8732.9 8740.3 8742.4 8783.1 8510.9 8689.7 8838.7 8838.9 8930.3 6428.3 7310.8 7418.1 7418.1 7447.5 6052.2 7260.9 7269.8 7444.1 7450.4 6470.9 6479.5 6620.4 6664.3 6717.5 6614.4 6641.9 6674.3 6678.7 6764.1 6137.9 6229.7 6232.0 6242.9 6244.3 4410.6 4499.3 4540.5 4597.7 4616.9 4503.4 4515.9 4622.5 4638.0 4715.3 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | [#4] prototype.html Cycles:180 Average:4108.41 Median:4618.30 stddev:1241.40 (26.9%) stddev-sans-first:1210.89 13:52:47 INFO - PROCESS | 10050 | Values: 264.7 265.3 271.1 273.7 277.5 4869.7 4895.2 4896.3 4907.8 4921.5 4839.2 4841.0 4841.2 4848.0 4848.9 3773.2 3773.3 3780.3 3782.7 3795.7 3783.7 3792.3 3796.3 3800.1 3803.5 3412.6 3657.9 3692.6 3747.7 3760.0 3691.5 3702.8 3704.5 3710.3 3710.8 3198.8 3202.3 3205.8 3209.8 3212.2 4488.3 4585.5 4625.2 4721.3 4735.9 4191.5 4195.1 4197.9 4201.8 4207.5 5061.2 5063.1 5067.7 5075.2 5076.9 3209.9 3221.7 3383.3 3384.4 3413.4 5271.6 5284.7 5291.9 5293.1 5295.0 3588.9 3595.4 3601.2 3603.6 3605.9 3503.4 3609.0 3631.4 3642.1 3648.1 4162.1 4171.7 4172.5 4175.7 4185.7 5038.8 5045.3 5047.3 5053.9 5066.2 1216.2 1247.1 1249.8 1258.4 1261.8 774.9 788.1 792.6 795.3 796.7 3927.5 3934.7 3958.0 3971.3 3978.4 4568.5 4603.4 4604.2 4610.3 4611.4 3823.5 3883.5 3969.6 3975.7 3997.2 2442.1 2455.9 2462.3 2470.0 2470.7 4282.4 4285.4 4312.6 4333.0 4633.2 5187.5 5224.8 5331.6 5383.4 5387.2 4907.3 4909.2 4910.3 4914.5 4918.2 5045.4 5200.4 5254.6 5261.6 5267.9 5078.8 5107.3 5121.6 5124.9 5143.9 4831.3 4847.2 4902.1 4905.2 4907.7 3488.4 3544.4 3585.7 3595.7 3598.1 5161.3 5195.0 5218.0 5234.9 5269.5 5064.6 5073.0 5094.9 5097.0 5115.3 4851.2 5049.7 5076.7 5097.5 5128.2 5008.5 5024.7 5043.7 5046.6 5046.6 5117.2 5124.7 5125.8 5153.4 5162.9 4878.5 4936.9 4966.5 5029.5 5036.3 13:52:47 INFO - PROCESS | 10050 | 13:52:47 INFO - PROCESS | 10050 | [#5] yui.html Cycles:180 Average:16993.19 Median:22246.23 stddev:23595.23 (106.1%) stddev-sans-first:23629.49 13:52:47 INFO - PROCESS | 10050 | Values: 644.9 677.7 678.0 682.6 683.8 13011.7 13733.5 14054.3 14089.3 14162.2 13421.4 13494.9 13550.7 13552.5 13556.3 602.1 619.1 739.0 758.0 758.5 738.2 757.9 765.1 765.1 766.6 793.0 795.2 795.5 795.5 795.7 623.1 639.7 789.4 789.6 790.1 471.5 471.9 472.4 563.6 581.0 12563.6 12566.3 12602.6 12693.2 12693.9 12508.7 12834.4 13182.3 13192.1 13418.7 11521.3 11603.8 11782.0 11844.6 12202.3 4013.7 4063.7 4117.8 4141.8 4171.1 60757.7 61500.4 61619.7 61640.7 61655.1 10225.6 10230.0 10357.7 10413.4 10541.1 19233.9 19380.9 19391.6 19434.5 19449.7 6755.7 6773.1 6944.3 7039.6 7197.7 3687.6 3709.2 3721.5 3722.3 3723.5 2681.9 2781.8 2810.1 2811.9 2813.9 473.2 476.2 482.6 496.2 500.6 456.8 504.7 508.6 560.1 563.4 7481.2 7737.2 7757.7 7788.4 7792.2 462.2 479.2 492.2 505.7 519.3 3625.7 3722.1 3826.6 3916.2 3970.6 94454.0 95109.0 96693.0 97399.5 100292.0 44576.8 80846.0 84158.0 85024.1 89075.6 41915.4 42364.6 48433.0 68822.0 70358.3 8147.8 8364.9 8444.8 8482.1 8618.5 33176.2 37517.4 40275.6 40428.7 45007.1 45380.3 49457.3 64002.7 70409.0 71870.0 11709.5 12423.8 12474.4 12746.6 12859.8 13283.1 13524.3 13562.5 13841.7 14256.4 12092.6 12111.4 12308.1 13007.4 13119.0 12334.0 12751.9 12784.4 13037.8 13102.3 11499.7 11840.0 12028.4 12411.2 13242.1 10327.0 10340.2 10650.2 11051.9 11110.4 10536.5 10840.8 11060.2 11072.1 11075.6 13:52:47 INFO - PROCESS | 10050 | -------- Summary: end -------- 13:52:47 INFO - PROCESS | 10050 | 13:52:48 INFO - TEST-INFO | 10050: exit 0 13:52:48 INFO - TEST-OK | dromaeo_css | took 1122039ms 13:52:48 INFO - TEST-START | kraken 13:52:48 INFO - operating with platform_type : linux_ 13:52:48 INFO - Initialising browser for kraken test... 13:52:48 INFO - TEST-INFO | started process 10362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNqL5AW/profile http://localhost:37266/getInfo.html) 13:52:53 INFO - PROCESS | 10362 | __metrics Screen width/height:1600/1200 13:52:53 INFO - PROCESS | 10362 | colorDepth:24 13:52:53 INFO - PROCESS | 10362 | Browser inner width/height: 1024/697 13:52:53 INFO - PROCESS | 10362 | __metrics 13:52:53 INFO - PROCESS | 10362 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:52:53 INFO - PROCESS | 10362 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:54 INFO - PROCESS | 10362 | console.error: PushService: 13:52:54 INFO - PROCESS | 10362 | stateChangeProcessEnqueue: Error transitioning state 13:52:54 INFO - PROCESS | 10362 | UnknownError 13:52:55 INFO - TEST-INFO | 10362: exit 0 13:52:55 INFO - Browser initialized. 13:52:55 INFO - Running cycle 1/1 for kraken test... 13:52:55 INFO - TEST-INFO | started process 10445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNqL5AW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:07 INFO - PROCESS | 10445 | RSS: Main: 174678016 13:53:07 INFO - PROCESS | 10445 | 13:53:10 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-beat-detection) 13:53:11 INFO - PROCESS | 10445 | RSS: Main: 236761088 13:53:11 INFO - PROCESS | 10445 | 13:53:13 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-dft) 13:53:14 INFO - PROCESS | 10445 | RSS: Main: 218017792 13:53:14 INFO - PROCESS | 10445 | 13:53:17 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-fft) 13:53:18 INFO - PROCESS | 10445 | RSS: Main: 300609536 13:53:18 INFO - PROCESS | 10445 | 13:53:20 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-oscillator) 13:53:21 INFO - PROCESS | 10445 | RSS: Main: 210935808 13:53:21 INFO - PROCESS | 10445 | 13:53:23 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:53:24 INFO - PROCESS | 10445 | RSS: Main: 214151168 13:53:24 INFO - PROCESS | 10445 | 13:53:27 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37266/tests/kraken/driver.html?testName=imaging-darkroom) 13:53:27 INFO - PROCESS | 10445 | RSS: Main: 250068992 13:53:27 INFO - PROCESS | 10445 | 13:53:31 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37266/tests/kraken/driver.html?testName=imaging-desaturate) 13:53:32 INFO - PROCESS | 10445 | RSS: Main: 244559872 13:53:32 INFO - PROCESS | 10445 | 13:53:34 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37266/tests/kraken/driver.html?testName=json-parse-financial) 13:53:35 INFO - PROCESS | 10445 | RSS: Main: 246595584 13:53:35 INFO - PROCESS | 10445 | 13:53:37 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:53:37 INFO - PROCESS | 10445 | RSS: Main: 210362368 13:53:37 INFO - PROCESS | 10445 | 13:53:39 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:53:40 INFO - PROCESS | 10445 | RSS: Main: 217710592 13:53:40 INFO - PROCESS | 10445 | 13:53:42 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:53:43 INFO - PROCESS | 10445 | RSS: Main: 226226176 13:53:43 INFO - PROCESS | 10445 | 13:53:45 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:53:46 INFO - PROCESS | 10445 | RSS: Main: 234979328 13:53:46 INFO - PROCESS | 10445 | 13:53:49 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:53:50 INFO - PROCESS | 10445 | RSS: Main: 231993344 13:53:50 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37266/tests/kraken/driver.html?testName=ai-astar) 13:53:52 INFO - PROCESS | 10445 | RSS: Main: 283344896 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | __start_tp_report 13:53:52 INFO - PROCESS | 10445 | _x_x_mozilla_page_load 13:53:52 INFO - PROCESS | 10445 | _x_x_mozilla_page_load_details 13:53:52 INFO - PROCESS | 10445 | |i|pagename|runs| 13:53:52 INFO - PROCESS | 10445 | |0;ai-astar;112;114;114;114;114;114;114;114;114;116 13:53:52 INFO - PROCESS | 10445 | |1;audio-beat-detection;151;131;127;184;136;130;131;126;163;131 13:53:52 INFO - PROCESS | 10445 | |2;audio-dft;162;162;162;163;163;162;164;162;163;162 13:53:52 INFO - PROCESS | 10445 | |3;audio-fft;76;75;75;112;77;77;76;77;100;76 13:53:52 INFO - PROCESS | 10445 | |4;audio-oscillator;84;83;121;83;84;83;106;84;84;125 13:53:52 INFO - PROCESS | 10445 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:53:52 INFO - PROCESS | 10445 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 13:53:52 INFO - PROCESS | 10445 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 13:53:52 INFO - PROCESS | 10445 | |8;json-parse-financial;65;64;65;64;65;65;66;65;65;65 13:53:52 INFO - PROCESS | 10445 | |9;json-stringify-tinderbox;66;66;66;65;67;66;66;66;67;67 13:53:52 INFO - PROCESS | 10445 | |10;stanford-crypto-aes;83;84;90;82;83;83;87;83;83;82 13:53:52 INFO - PROCESS | 10445 | |11;stanford-crypto-ccm;152;145;148;141;142;138;138;138;193;146 13:53:52 INFO - PROCESS | 10445 | |12;stanford-crypto-pbkdf2;175;176;176;181;181;178;180;182;179;178 13:53:52 INFO - PROCESS | 10445 | |13;stanford-crypto-sha256-iterative;70;69;74;71;71;69;71;69;68;70 13:53:52 INFO - PROCESS | 10445 | __end_tp_report 13:53:52 INFO - PROCESS | 10445 | __start_cc_report 13:53:52 INFO - PROCESS | 10445 | _x_x_mozilla_cycle_collect,1938 13:53:52 INFO - PROCESS | 10445 | __end_cc_report 13:53:52 INFO - PROCESS | 10445 | __startTimestamp1476046432427__endTimestamp 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | ------- Summary: start ------- 13:53:52 INFO - PROCESS | 10445 | Number of tests: 14 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 13:53:52 INFO - PROCESS | 10445 | Values: 112.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:133.50 stddev:19.15 (14.3%) stddev-sans-first:19.97 13:53:52 INFO - PROCESS | 10445 | Values: 151.0 131.0 127.0 184.0 136.0 130.0 131.0 126.0 163.0 131.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 13:53:52 INFO - PROCESS | 10445 | Values: 162.0 162.0 162.0 163.0 163.0 162.0 164.0 162.0 163.0 162.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.93 (17.0%) stddev-sans-first:13.53 13:53:52 INFO - PROCESS | 10445 | Values: 76.0 75.0 75.0 112.0 77.0 77.0 76.0 77.0 100.0 76.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.50 stddev:16.98 (20.3%) stddev-sans-first:17.65 13:53:52 INFO - PROCESS | 10445 | Values: 84.0 83.0 121.0 83.0 84.0 83.0 106.0 84.0 84.0 125.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:53:52 INFO - PROCESS | 10445 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 13:53:52 INFO - PROCESS | 10445 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:53:52 INFO - PROCESS | 10445 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 13:53:52 INFO - PROCESS | 10445 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 66.0 65.0 65.0 65.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:53:52 INFO - PROCESS | 10445 | Values: 66.0 66.0 66.0 65.0 67.0 66.0 66.0 66.0 67.0 67.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:2.54 (3.1%) stddev-sans-first:2.67 13:53:52 INFO - PROCESS | 10445 | Values: 83.0 84.0 90.0 82.0 83.0 83.0 87.0 83.0 83.0 82.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.50 stddev:16.46 (11.3%) stddev-sans-first:17.40 13:53:52 INFO - PROCESS | 10445 | Values: 152.0 145.0 148.0 141.0 142.0 138.0 138.0 138.0 193.0 146.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.50 stddev:2.41 (1.3%) stddev-sans-first:2.18 13:53:52 INFO - PROCESS | 10445 | Values: 175.0 176.0 176.0 181.0 181.0 178.0 180.0 182.0 179.0 178.0 13:53:52 INFO - PROCESS | 10445 | 13:53:52 INFO - PROCESS | 10445 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.69 (2.4%) stddev-sans-first:1.79 13:53:52 INFO - PROCESS | 10445 | Values: 70.0 69.0 74.0 71.0 71.0 69.0 71.0 69.0 68.0 70.0 13:53:52 INFO - PROCESS | 10445 | -------- Summary: end -------- 13:53:52 INFO - PROCESS | 10445 | 13:53:53 INFO - TEST-INFO | 10445: exit 0 13:53:53 INFO - TEST-OK | kraken | took 64943ms 13:53:53 INFO - SUITE-END | took 1186s 13:53:54 INFO - Completed test suite (00:19:47) 13:53:54 INFO - javascript benchmark 13:53:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.897644094236, 2594.377349436136, 2625.842449453033, 2640.4983053219885, 2651.0853755454373, 4569.862904112873, 4618.676692631517, 4724.503927087653, 4734.763261836907, 4749.762511874401, 4656.41794775653, 4663.370444989925, 4699.976500117503, 4743.146233677937, 4745.311929770181, 4241.4698162729655, 4242.745435273878, 4297.35539669049, 4317.0, 4358.97820510897, 4053.2298863215897, 4358.193734159191, 4367.672424568154, 4397.802098905557, 4445.533219012005, 4255.659547236244, 4348.673849461272, 4393.143337049277, 4456.532064133268, 4506.707064040843, 4271.67962402821, 4317.589828966243, 4336.761478118702, 4342.630876375511, 4353.434053573047, 4338.2191205582985, 4343.109662519208, 4386.649068074546, 4395.318725597537, 4405.867823965286, 4654.790534425959, 4676.906461870778, 4693.671442998992, 4717.646176536773, 4770.379850619432, 4876.853694389174, 4884.267359896008, 4916.0, 5045.621578381636, 5047.596192304607, 5003.099442100421, 5018.146915024455, 5026.1204289249235, 5047.697138171721, 5077.64456488046, 4674.719516829001, 4680.485146633936, 4680.95319046812, 4682.0, 4737.2183589708, 4901.485344038896, 4936.975315123474, 5104.464031276662, 5108.565771909355, 5162.483751624883, 4873.829415970424, 4889.828855990023, 4897.583705385011, 4922.827701030446, 4967.081089998362, 4940.530649588283, 4951.529604687549, 5024.095662780662, 5028.0, 5099.821506247264, 4816.229403295456, 4853.878653033632, 4977.377827771528, 4989.376327959005, 4991.700497970133, 4922.630802689812, 4972.925406118911, 4974.8756281093265, 4975.10448119342, 4990.675606085593, 4319.697621166488, 4324.394584758136, 4332.285172946492, 4389.890252743643, 4390.714603550759, 3703.092742278105, 3717.2379662169733, 3765.3787125124595, 3777.320082385197, 3843.1160833008566, 4274.529801721808, 4280.871573852789, 4294.699371044059, 4308.676849236257, 4381.3208952612395, 5039.168537191323, 5075.543201111844, 5080.26336181259, 5080.720560369141, 5144.099782538041, 4317.222899878052, 4324.740515569076, 4327.7619730914475, 4331.5884990925815, 4381.759003254788, 4440.289553671397, 4492.326151077365, 4492.618127459203, 4554.066416384633, 4603.631709463235, 4783.473817879961, 4824.927626085611, 4828.444728856086, 4837.7097374157665, 4839.080574690797, 5083.2883396323805, 5084.466131056186, 5084.542391184811, 5091.389033316026, 5140.254663073908, 4593.26507758757, 4759.809607615656, 4776.617870570415, 4777.211760059551, 4826.107170173529, 4795.784189711541, 4808.927866081942, 4833.540813622701, 4858.0, 4891.437484689306, 4860.392450943632, 4899.461059283405, 4905.0, 4911.0, 4969.428515720739, 4742.383490146259, 4785.712857228438, 4789.066132104206, 4789.568938795525, 4847.491013443679, 4781.306710526885, 4828.565429111397, 4868.805247790048, 4923.950760492349, 4926.48271931442, 4863.586595139312, 4866.829660961849, 4869.780859861244, 4926.655134140576, 4933.062718083553, 4972.676776009548, 4973.502649734997, 4975.278584605285, 4975.378077740283, 4975.452700203047, 4702.824293926518, 4725.432948046119, 4747.074320507468, 4773.021530586291, 4911.901761964669], "value": 4606.724817513899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.69620164607, 548.8024311247952, 558.7904535799075, 570.7060863655219, 573.2977103048765, 26765.197044088683, 36217.45673814892, 37211.4418283726, 37245.62754372456, 41848.58151418485, 38321.425178622274, 38437.807810960905, 38442.615573844254, 38483.422748658726, 38549.80725096378, 7599.430042746802, 7749.535027898316, 7754.379649628045, 7758.340541054017, 7759.495632783851, 7360.07999000125, 7444.925550744504, 7450.8137296567475, 7453.068366454193, 7455.664495097733, 7450.478466507347, 7480.62596870157, 7488.32605065544, 7497.025386699722, 7498.462815122887, 7423.109226892753, 7449.664765085584, 7451.068616422947, 7460.328570428634, 7462.85074298511, 7529.9247007529775, 7613.467057305991, 7614.428917831185, 7615.847683046363, 7620.580868052255, 36280.0, 36725.081872953124, 36738.0, 36851.81574092139, 36892.81553592215, 3034.8179109253297, 3043.9695603043906, 3080.122165182912, 3264.6898544638457, 3594.029612004744, 27622.723772762216, 27894.0, 28371.85814070937, 28378.85810570934, 28918.132456026142, 3401.234722187513, 3455.2571197192474, 3465.9653403466145, 3501.107217659506, 3510.1224693826543, 244499.0, 244742.0, 245122.7743861287, 245491.0, 246367.0, 30535.541966870514, 49660.25509617358, 49903.0, 49951.75024124929, 50067.0, 31103.377932441224, 33078.3384332312, 33175.502367464505, 33242.66757332395, 33276.83361583177, 12281.815772763415, 12312.199707019015, 12312.692182695326, 12340.50637974489, 12343.938280308541, 10509.527071281811, 10510.054095131474, 10525.315854469434, 10530.10494107994, 10543.57825686964, 7729.5748733819055, 7770.057485628593, 7858.803529911798, 7896.368290536743, 7921.960390198012, 3046.9238269043008, 3046.9238269043453, 3118.469860123784, 3131.185891668137, 3146.0404576604355, 799.4403917257943, 868.8305780372893, 882.6910581296495, 921.3918813583003, 972.2173650211647, 25059.373515662253, 26704.931802727675, 26799.19602411931, 27091.729082709317, 27302.863485682443, 741.9146798118286, 961.7932144588807, 987.6592575561419, 999.480270259461, 1027.1833892055834, 13898.374573144232, 13975.440982360795, 14296.642583935276, 14308.928455357656, 14363.353649085817, 357987.0, 360193.0, 360220.0, 360439.0, 360694.0, 46791.0, 47261.29108063382, 47268.7636561815, 47296.763516182196, 47302.5269747305, 1053.210092430677, 1086.413336798136, 1086.6631344283298, 1164.7903377392151, 1194.510250797169, 23403.531929360975, 27487.17538473849, 28526.85736571304, 30569.388612228075, 30670.84664576663, 43987.78006109949, 44846.77576612096, 44855.551444485136, 44879.0, 44896.0, 321647.0, 324837.0, 325256.0, 325341.0, 325428.0, 21635.459113522287, 21941.476730176233, 22090.77909220887, 24270.87864560666, 24710.629340560266, 39493.80253098716, 39656.60343396645, 39712.60287397089, 39926.00184995282, 39995.80002099971, 33710.0, 34234.315313693085, 34505.48241776426, 34919.301613968084, 34964.82517587396, 33384.33231335311, 33812.323753525285, 33932.830335848164, 34141.0, 34874.82562587171, 33626.159346016546, 33963.66036339704, 34168.31663366769, 34360.48459273163, 34396.0, 28926.409047502588, 31106.688933110378, 31403.68596314099, 31405.0, 31636.841815790773, 23914.760852391253, 23969.880150599136, 23975.76024239735, 24393.878030609732, 24665.260042198763], "value": 15874.143894330033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.90461766087833, 329.50080627848814, 347.64540169027595, 347.885197884698, 371.7973704331141, 12026.338551379671, 13044.60866174015, 15274.92362538187, 15506.61233469161, 16363.0, 16318.918405407956, 16470.258838352274, 16474.0, 16489.257983390748, 16752.329906803712, 3940.8965489662796, 4809.182438985381, 5027.145385284511, 5032.11937910866, 5032.547070763649, 4857.441394239655, 4936.407631084275, 4946.060248552782, 4946.604271658259, 4947.257911313314, 4869.0, 4869.196582563891, 4870.147724148278, 4871.8782030449165, 4876.0, 4878.756062196876, 5148.253503242027, 5178.5857131429775, 5271.28837606922, 5284.128118860383, 4890.853274401774, 5129.1024070787835, 5134.0758663440565, 5139.614528910347, 5140.614453915971, 11470.827937580943, 11820.940895295469, 11833.349165795878, 11835.704107397298, 11837.467313970892, 1868.8037756035692, 1886.6604011277964, 1889.310401703382, 1894.8673592848506, 1934.2456441987636, 8625.956870215672, 8630.741077767614, 8803.955980220122, 9061.456312621263, 9326.02076781935, 1606.702759989394, 1635.6319828038716, 1650.4306014425124, 1747.7075588599753, 1786.606946471774, 64439.0, 64672.3532764671, 66360.66819665919, 67080.99378509278, 67897.32102679009, 8253.298469630028, 8506.959194382742, 8954.373193876496, 8963.775905602282, 10052.145567626834, 11679.0, 11704.122190835722, 11793.233439826385, 11794.823077653842, 11805.055595552507, 7102.218755936843, 7107.71569137239, 7248.782536523912, 7319.74380896666, 7361.595112268877, 6624.327115439325, 6786.321367863175, 6883.036374907517, 7014.070704921002, 7124.287571242834, 3699.8520059197867, 3723.162288485069, 3745.7003439725304, 3788.090858194069, 3842.8462861485227, 1737.1835237438384, 1740.1473278093642, 1778.199810085441, 1851.3057603398724, 1855.4526414707693, 793.1394437035765, 821.1665159862744, 827.4993628854577, 879.8812160358398, 882.668999125328, 15823.367065317258, 16576.75134872978, 17047.31810727557, 17105.401310954057, 17343.392981245597, 836.4730219961507, 844.9450785698909, 894.7718331825342, 902.9187373136318, 910.7677542226822, 9043.231325337289, 9691.806163876823, 9701.07839755222, 9721.270904682036, 9859.50702464874, 263796.0, 266141.0, 355628.0, 357211.0, 360075.0, 80804.0, 81337.59331203306, 81373.59313203396, 82245.17754822495, 82835.5858220717, 886.2511178054533, 902.0483390023588, 924.1497822003772, 927.758782716485, 928.4707716601607, 15418.46035388756, 15424.0, 16066.43767468133, 16273.74525094962, 16388.83611163873, 35339.29321413609, 35697.28605427929, 35785.46321805227, 36440.45339319859, 36746.816265918496, 47901.28148077851, 50685.74657126691, 50980.0, 51370.22944655908, 51983.74008129935, 6883.518153729391, 6957.060796792571, 7053.1536215652395, 7142.285771422816, 7255.165655949633, 6102.084687296941, 8866.64533418656, 9673.854892176763, 10616.469176541297, 10647.946760266459, 8575.699850505202, 9383.202427793714, 9508.952455237679, 9543.713688589354, 9615.23078153732, 9424.198943089914, 9565.426074435556, 9720.465374404193, 9725.270604704534, 9734.659286924923, 9440.0, 9578.56896439648, 9663.178629816544, 9972.152367048591, 10086.092251697382, 6393.6163830170335, 7078.1506219254015, 7669.846603068019, 7694.422918281263, 8036.959815200887, 9019.458832470073, 9461.952690236505, 9555.665551705657, 10504.632337868443, 10597.62908298206], "value": 7652.529029753724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.9516019359226, 1321.3195204469696, 1360.6530334764634, 1366.8564800695926, 1618.9028658280497, 6248.218972628421, 7315.9634201828985, 7509.924900750998, 7533.510321829077, 7785.41609379296, 7572.772816815491, 7662.808429789258, 7663.118741344747, 7668.884966725504, 7686.730964416247, 2024.7165396844453, 2065.070718176819, 2066.60734460452, 2067.886266255355, 2069.8758074515504, 2104.4318034130774, 2141.0365335598963, 2150.311900191939, 2150.3656421355736, 2157.967630485544, 2082.3138151784256, 2090.770015298316, 2102.5899949509853, 2105.705201271823, 2112.12346876047, 2023.4435530229157, 2031.695245713155, 2039.5920815836819, 2041.1529215375601, 2042.4689580708973, 1987.8210961013433, 2013.1041686449537, 2047.7337946066916, 2047.938561843147, 2048.4366799130207, 7547.05661792276, 7629.160792312841, 7703.114141873701, 7708.075030996316, 7739.7678069658, 4342.32693932441, 4532.592066713979, 4533.818647254106, 4539.228331183706, 4540.636749060101, 2561.7694407503227, 2664.4138289576263, 2715.945681086387, 2725.645666063399, 2732.699403065661, 850.2602735620051, 856.1823458597025, 862.7023676831483, 868.9261412779921, 880.3617377401333, 10432.791344173074, 10479.895201047968, 10492.737681557946, 10573.3127346723, 10584.735381615521, 3613.33153366628, 3729.6083911188935, 3789.4315852621776, 3867.497225360685, 3870.4000879863665, 8119.269265766109, 8128.268455839003, 8148.796280093045, 8150.38872084596, 8154.469959452736, 4383.868483945486, 4384.101259241847, 4391.802368893407, 4392.143532011291, 4396.978015109968, 3341.131305860445, 3444.190615205425, 3968.6825053995613, 4095.1400205957084, 4113.03343714227, 3277.655846136169, 3285.490748933871, 3384.2385463270566, 3387.288669379458, 3393.8472768725464, 994.9005099489993, 1012.2408193854609, 1014.91373233276, 1022.1720406470633, 1032.200044965158, 703.7818276334352, 825.3026192867018, 844.2317491083085, 850.7702920211508, 853.3642436384933, 5093.923591146136, 5145.099607568661, 5196.220566914917, 5299.655522391032, 5377.274068000848, 374.32247631786555, 391.1707180776771, 392.2997449552535, 394.2076426382991, 397.239286765846, 3580.051286409104, 3735.402335626287, 3737.32728108943, 3801.1067399161175, 3812.8665496708036, 8945.37382383227, 9203.585838637277, 9532.0, 9578.701111733133, 9620.90379096214, 9378.109079637423, 9507.952460237655, 9508.381955172892, 9508.857367139499, 9534.666286679932, 7025.754098606524, 7051.858962820715, 7063.646817659199, 7184.9640751795905, 7194.748183813542, 5304.60215483848, 5322.254884316276, 5372.774822209688, 5454.836354909359, 5481.369642491165, 8716.738497845075, 8732.869006964773, 8740.300775938036, 8742.431741936754, 8783.077776833596, 8510.914890851012, 8689.652413903374, 8838.690645827364, 8838.867416988622, 8930.285577153682, 6428.292887782247, 7310.780676579711, 7418.146913105062, 7418.146913105062, 7447.515911465737, 6052.243469566304, 7260.89108663381, 7269.818254543678, 7444.106707195171, 7450.36671882896, 6470.870582588228, 6479.514036447191, 6620.3710647488415, 6664.300248474035, 6717.529772915849, 6614.404703576509, 6641.867162656817, 6674.299198584079, 6678.666066696548, 6764.0868482754195, 6137.907931381123, 6229.719662615284, 6231.9688401557705, 6242.938700420848, 6244.250689917239, 4410.603045725772, 4499.30260809562, 4540.545945405433, 4597.7241365518175, 4616.8614941551805, 4503.414556107685, 4515.887102822456, 4622.537746225351, 4637.953620463887, 4715.292706094114], "value": 3906.6996032162497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.6876685511097, 265.32342526557284, 271.1445389795196, 273.6784278472794, 277.4589550376765, 4869.68347057441, 4895.21676531755, 4896.314515967763, 4907.7975895905465, 4921.465445295671, 4839.153148199069, 4840.951590484094, 4841.225403935371, 4847.975760121203, 4848.878778030551, 3773.18876441565, 3773.339665558516, 3780.319542482352, 3782.678472329855, 3795.734298599099, 3783.69730421567, 3792.2506183017367, 3796.2787070456525, 3800.068983099131, 3803.50554427924, 3412.5904891412943, 3657.9268414631692, 3692.5568931728094, 3747.718921080916, 3759.9812000939955, 3691.464737613058, 3702.7963462009443, 3704.4998925145164, 3710.2579484103017, 3710.8330125144435, 3198.792078514889, 3202.3115030268605, 3205.8397080146133, 3209.823459709715, 3212.1969507623094, 4488.259437192859, 4585.541445855421, 4625.190591646448, 4721.26820342844, 4735.905281894343, 4191.476065491814, 4195.098053918422, 4197.91604167918, 4201.848613539845, 4207.506335251003, 5061.16490779021, 5063.11395505785, 5067.695938243681, 5075.238714192864, 5076.949230507685, 3209.871605135792, 3221.6617255188103, 3383.2556837495713, 3384.3908096542614, 3413.385590593692, 5271.5782737381305, 5284.682919024871, 5291.894162116736, 5293.126634105368, 5295.0, 3588.9102772430897, 3595.3528364894046, 3601.243738814826, 3603.5855876574005, 3605.9278814423565, 3503.4219353806848, 3608.986496275639, 3631.364511210528, 3642.1440961374055, 3648.069742215771, 4162.063535704442, 4171.749695018309, 4172.541020487804, 4175.749455032707, 4185.748855068706, 5038.79844806211, 5045.318881950963, 5047.343845300161, 5053.9241911371355, 5066.16408292635, 1216.1669256559107, 1247.1457051919465, 1249.8062800265973, 1258.3829778734282, 1261.7602655495427, 774.8915151878741, 788.1487992967582, 792.6116203060574, 795.316028215734, 796.6536553225031, 3927.489426374553, 3934.685225182036, 3957.9604203957592, 3971.3050216212046, 3978.42312864633, 4568.543145685405, 4603.401557797465, 4604.217283061887, 4610.2623580227, 4611.400517932647, 3823.502944617182, 3883.5339759229073, 3969.5511138434263, 3975.7018223633345, 3997.240524300432, 2442.1330427698267, 2455.8772061397217, 2462.3351695042597, 2469.9753002470106, 2470.7152280813875, 4282.421873047161, 4285.442892423965, 4312.5903039211225, 4333.0, 4633.212353899845, 5187.507186817246, 5224.817131400383, 5331.600129990189, 5383.43473935239, 5387.164989426645, 4907.337509436252, 4909.214525675875, 4910.312556242129, 4914.459409465027, 4918.188498897642, 5045.445001049955, 5200.401953775364, 5254.633795213195, 5261.553072904829, 5267.89464210706, 5078.822241221539, 5107.336046313955, 5121.590272778094, 5124.897502050013, 5143.871403214949, 4831.255776773029, 4847.151748444078, 4902.142125128017, 4905.2151655734915, 4907.705537667752, 3488.424409972326, 3544.4328907374697, 3585.659362360676, 3595.6763891248866, 3598.1184609770776, 5161.277421160966, 5195.0, 5217.973910130577, 5234.921476177937, 5269.525742683177, 5064.620153488429, 5073.021521606503, 5094.923576146435, 5096.961215513824, 5115.335006449138, 4851.199552073868, 5049.722265275298, 5076.670016448919, 5097.464766199496, 5128.205128205134, 5008.524190201925, 5024.698518088926, 5043.722595257296, 5046.621503387334, 5046.646734728681, 5117.232415137759, 5124.666896651705, 5125.820596279113, 5153.3558305211845, 5162.922556161586, 4878.463369029333, 4936.8765780855765, 4966.453690094159, 5029.547340739351, 5036.269740887477], "value": 3704.4144654625634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.9484041276697, 677.7458453080095, 678.0236459498323, 682.621145264378, 683.8085336105889, 13011.73976520469, 13733.519326823563, 14054.29728513574, 14089.29553522325, 14162.150270983722, 13421.396037178327, 13494.932525337359, 13550.72898542031, 13552.457901683945, 13556.254406007665, 602.1239097113711, 619.1177571959962, 738.951968122073, 758.0145810446426, 758.4956004257162, 738.1584993107834, 757.9393648508106, 765.0666187251544, 765.0704394161094, 766.6205228411916, 792.9722459713911, 795.2326005404783, 795.5107608820591, 795.5465384730705, 795.6976348987376, 623.1369553168848, 639.7249182851372, 789.3645615279697, 789.6288744290174, 790.0637744273055, 471.5143402295641, 471.93156992236277, 472.4094881398252, 563.6336381352113, 580.9506191973687, 12563.623091307276, 12566.30885301308, 12602.621921342374, 12693.238405695596, 12693.873061269362, 12508.74982500345, 12834.422450989634, 13182.34088295591, 13192.142510736772, 13418.731625367438, 11521.284917860768, 11603.825942610867, 11782.0, 11844.585439509576, 12202.328871912041, 4013.6588389986887, 4063.7358571692744, 4117.75293482392, 4141.834326626931, 4171.124063946575, 60757.69621151866, 61500.384996149915, 61619.69190154065, 61640.69179654118, 61655.07517387243, 10225.590976360862, 10230.0, 10357.689269321932, 10413.42726150069, 10541.104006159563, 19233.90383048076, 19380.903095484715, 19391.612167756564, 19434.5141371464, 19449.708254376197, 6755.695993680296, 6773.051772751819, 6944.305569443015, 7039.577625342496, 7197.748078817321, 3687.59436461989, 3709.1839795245005, 3721.4603882436895, 3722.3299806035175, 3723.5345581802276, 2681.9061332853257, 2781.8330900146057, 2810.086721815418, 2811.8594070296404, 2813.9296517587222, 473.197929509485, 476.22613253463123, 482.6114977443122, 496.2432290756625, 500.6395395315367, 456.80129143822546, 504.6870940017213, 508.55501436243287, 560.1150182711307, 563.4056070845215, 7481.177070522238, 7737.2262773723305, 7757.72847950319, 7788.415868809749, 7792.181820908723, 462.23961583195455, 479.1853848457636, 492.2468623006805, 505.7243802127849, 519.3326575350657, 3625.728070394731, 3722.088088418355, 3826.579076301605, 3916.243122609759, 3970.6029397060065, 94454.0, 95109.0, 96693.0, 97399.51300243595, 100292.0, 44576.777116114215, 80846.0, 84158.0, 85024.14975850286, 89075.55462222647, 41915.371269430376, 42364.57635423668, 48433.0, 68822.0, 70358.29641703518, 8147.7816262577135, 8364.874526882224, 8444.831103378021, 8482.109378515413, 8618.482891026559, 33176.17059573434, 37517.43723844199, 40275.59724402836, 40428.722829889724, 45007.099858002, 45380.31929521126, 49457.25814112863, 64002.67998659977, 70409.0, 71870.0, 11709.473073711533, 12423.751524969632, 12474.438650260941, 12746.617601471971, 12859.807102893277, 13283.136596121221, 13524.256165910969, 13562.457501699822, 13841.723165536432, 14256.358463868943, 12092.637220883387, 12111.394430278628, 12308.138430309793, 13007.414666340226, 13119.022184682115, 12334.0, 12751.872481275068, 12784.360781961052, 13037.804432933703, 13102.344882756015, 11499.655010349703, 11840.0, 12028.398580071136, 12411.193272437262, 13242.073054886065, 10327.010437979152, 10340.172786176938, 10650.201234907569, 11051.889481105087, 11110.44447777624, 10536.473176340998, 10840.783184336427, 11060.17048721333, 11072.114230861673, 11075.5569777208], "value": 6473.545854970113, "unit": "score"}], "name": "dromaeo_css", "value": 6117.88374805526, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 127.0, 184.0, 136.0, 130.0, 131.0, 126.0, 163.0, 131.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 164.0, 162.0, 163.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 112.0, 77.0, 77.0, 76.0, 77.0, 100.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 121.0, 83.0, 84.0, 83.0, 106.0, 84.0, 84.0, 125.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 90.0, 82.0, 83.0, 83.0, 87.0, 83.0, 83.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 145.0, 148.0, 141.0, 142.0, 138.0, 138.0, 138.0, 193.0, 146.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 176.0, 181.0, 181.0, 178.0, 180.0, 182.0, 179.0, 178.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 74.0, 71.0, 71.0, 69.0, 71.0, 69.0, 68.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1563.3999999999999, "alertThreshold": 2.0}]} 13:53:54 INFO - Return code: 0 13:53:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:53:54 INFO - # TBPL SUCCESS # 13:53:54 INFO - Running post-action listener: _resource_record_post_action 13:53:54 INFO - [mozharness: 2016-10-09 20:53:54.232301Z] Finished run-tests step (success) 13:53:54 INFO - Running post-run listener: _resource_record_post_run 13:53:54 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391798784; Read time: 12; Write time: 238432 13:53:54 INFO - TinderboxPrint: CPU usage
13.1% 13:53:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:53:54 INFO - TinderboxPrint: I/O write bytes / time
391,798,784 / 238,432 13:53:54 INFO - TinderboxPrint: CPU idle
8,350.2 (86.9%) 13:53:54 INFO - TinderboxPrint: CPU user
1,206.5 (12.6%) 13:53:54 INFO - TinderboxPrint: Swap in / out
0 / 0 13:53:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99495936; Read time: 0; Write time: 76820 13:53:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291688448; Read time: 0; Write time: 161612 13:53:54 INFO - Running post-run listener: _upload_blobber_files 13:53:54 INFO - Blob upload gear active. 13:53:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:53:54 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 13:53:54 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'] 13:53:54 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 13:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 13:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:58 INFO - (blobuploader) - INFO - Done attempting. 13:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:59 INFO - (blobuploader) - INFO - Done attempting. 13:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:59 INFO - (blobuploader) - INFO - Done attempting. 13:53:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:53:59 INFO - Return code: 0 13:53:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:53:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:53:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c186911be9b6fe1795eb13ca7b386d0b8bbe9774ccde6c63d7cf8305a83ed2c825729a6774ce15b4f574b3a76305bb190f7fa761cab4dc48b4802d3cee3a1e39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5911401f38dcaa9a908cdafaad9bd9587ab2233b893292e658480711f2d4be372578b836ff799e949559ce7163f5041ca912faf56fdf5662519cecb6c9a8a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62d01cb0a2dcbbdc58c26ce22ff9a21b0fe0d6729627c83cb8fbd0c45a15dc083b34230dcf7e63bd289cfec5d39f3c6e152ec9c85f8017f2216032b3134d16c1"} 13:53:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:53:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:53:59 INFO - Contents: 13:53:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c186911be9b6fe1795eb13ca7b386d0b8bbe9774ccde6c63d7cf8305a83ed2c825729a6774ce15b4f574b3a76305bb190f7fa761cab4dc48b4802d3cee3a1e39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5911401f38dcaa9a908cdafaad9bd9587ab2233b893292e658480711f2d4be372578b836ff799e949559ce7163f5041ca912faf56fdf5662519cecb6c9a8a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62d01cb0a2dcbbdc58c26ce22ff9a21b0fe0d6729627c83cb8fbd0c45a15dc083b34230dcf7e63bd289cfec5d39f3c6e152ec9c85f8017f2216032b3134d16c1"} 13:53:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:53:59 INFO - Copying logs to upload dir... 13:53:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:53:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.417096 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-09 13:53:59.126745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 13:53:59.130204) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c186911be9b6fe1795eb13ca7b386d0b8bbe9774ccde6c63d7cf8305a83ed2c825729a6774ce15b4f574b3a76305bb190f7fa761cab4dc48b4802d3cee3a1e39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5911401f38dcaa9a908cdafaad9bd9587ab2233b893292e658480711f2d4be372578b836ff799e949559ce7163f5041ca912faf56fdf5662519cecb6c9a8a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62d01cb0a2dcbbdc58c26ce22ff9a21b0fe0d6729627c83cb8fbd0c45a15dc083b34230dcf7e63bd289cfec5d39f3c6e152ec9c85f8017f2216032b3134d16c1"} build_url:https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/e5r5ZhhTSbCf6-B4KCwgOA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c186911be9b6fe1795eb13ca7b386d0b8bbe9774ccde6c63d7cf8305a83ed2c825729a6774ce15b4f574b3a76305bb190f7fa761cab4dc48b4802d3cee3a1e39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5911401f38dcaa9a908cdafaad9bd9587ab2233b893292e658480711f2d4be372578b836ff799e949559ce7163f5041ca912faf56fdf5662519cecb6c9a8a400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62d01cb0a2dcbbdc58c26ce22ff9a21b0fe0d6729627c83cb8fbd0c45a15dc083b34230dcf7e63bd289cfec5d39f3c6e152ec9c85f8017f2216032b3134d16c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 13:53:59.158622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:53:59.158962) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476043404.57082-109914534 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 13:53:59.244159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 13:53:59.244449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 13:53:59.244715) ========= ========= Total master_lag: 0.21 =========