builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1480341172.46 results: success (0) buildid: 20161128030212 builduid: 2fe0ce39798d48a8bbc3b670de3bb3be revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.463652) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.467136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.467446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.499953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.500230) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-28 05:52:52-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.3M=0s 2016-11-28 05:52:52 (45.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.649202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.649625) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018479 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.702766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:52.703148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05328d3102efd4d5fc0696489734d7771d24459f --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 05328d3102efd4d5fc0696489734d7771d24459f --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=a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-28 05:52:52,784 truncating revision to first 12 chars 2016-11-28 05:52:52,784 Setting DEBUG logging. 2016-11-28 05:52:52,784 attempt 1/10 2016-11-28 05:52:52,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05328d3102ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 05:52:53,143 unpacking tar archive at: mozilla-central-05328d3102ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693578 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:53.446835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:53.447140) ========= script_repo_revision: 05328d3102efd4d5fc0696489734d7771d24459f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:53.447530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:53.447824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 05:52:53.458985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-28 05:52:53.459281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:53 INFO - MultiFileLogger online at 20161128 05:52:53 in /builds/slave/test 05:52:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:53 INFO - {'append_to_log': False, 05:52:53 INFO - 'base_work_dir': '/builds/slave/test', 05:52:53 INFO - 'blob_upload_branch': 'Firefox', 05:52:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:53 INFO - 'branch': 'Firefox', 05:52:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:53 INFO - 'config_files': ('talos/linux_config.py',), 05:52:53 INFO - 'default_actions': ('clobber', 05:52:53 INFO - 'read-buildbot-config', 05:52:53 INFO - 'download-and-extract', 05:52:53 INFO - 'populate-webroot', 05:52:53 INFO - 'create-virtualenv', 05:52:53 INFO - 'install', 05:52:53 INFO - 'run-tests'), 05:52:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:53 INFO - 'download_minidump_stackwalk': True, 05:52:53 INFO - 'download_symbols': 'ondemand', 05:52:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:53 INFO - 'installer_path': 'installer.exe', 05:52:53 INFO - 'log_level': 'info', 05:52:53 INFO - 'log_name': 'talos', 05:52:53 INFO - 'log_to_console': True, 05:52:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:53 INFO - 'opt_config_files': (), 05:52:53 INFO - 'pip_index': False, 05:52:53 INFO - 'sps_profile': False, 05:52:53 INFO - 'sps_profile_interval': 0, 05:52:53 INFO - 'suite': 'dromaeojs', 05:52:53 INFO - 'system_bits': '32', 05:52:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:53 INFO - 'title': 'talos-linux64-ix-002', 05:52:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:53 INFO - 'use_talos_json': True, 05:52:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:53 INFO - 'work_dir': 'build'} 05:52:53 INFO - [mozharness: 2016-11-28 13:52:53.631988Z] Running clobber step. 05:52:53 INFO - Running pre-action listener: _resource_record_pre_action 05:52:53 INFO - Running main action method: clobber 05:52:53 INFO - rmtree: /builds/slave/test/build 05:52:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:54 INFO - Running post-action listener: _resource_record_post_action 05:52:54 INFO - [mozharness: 2016-11-28 13:52:54.612005Z] Finished clobber step (success) 05:52:54 INFO - [mozharness: 2016-11-28 13:52:54.612101Z] Running read-buildbot-config step. 05:52:54 INFO - Running pre-action listener: _resource_record_pre_action 05:52:54 INFO - Running main action method: read_buildbot_config 05:52:54 INFO - Using buildbot properties: 05:52:54 INFO - { 05:52:54 INFO - "project": "", 05:52:54 INFO - "product": "firefox", 05:52:54 INFO - "script_repo_revision": "production", 05:52:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:52:54 INFO - "repository": "", 05:52:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:52:54 INFO - "buildid": "20161128030212", 05:52:54 INFO - "stage_platform": "linux64-pgo", 05:52:54 INFO - "basedir": "/builds/slave/test", 05:52:54 INFO - "nightly_build": "True", 05:52:54 INFO - "buildnumber": 81, 05:52:54 INFO - "slavename": "talos-linux64-ix-002", 05:52:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:52:54 INFO - "platform": "ubuntu64_hw", 05:52:54 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:54 INFO - "branch": "mozilla-central", 05:52:54 INFO - "repo_path": "mozilla-central", 05:52:54 INFO - "revision": "05328d3102efd4d5fc0696489734d7771d24459f", 05:52:54 INFO - "pgo_build": "True", 05:52:54 INFO - "builduid": "2fe0ce39798d48a8bbc3b670de3bb3be", 05:52:54 INFO - "slavebuilddir": "test" 05:52:54 INFO - } 05:52:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 05:52:54 INFO - Running post-action listener: _resource_record_post_action 05:52:54 INFO - [mozharness: 2016-11-28 13:52:54.614575Z] Finished read-buildbot-config step (success) 05:52:54 INFO - [mozharness: 2016-11-28 13:52:54.614662Z] Running download-and-extract step. 05:52:54 INFO - Running pre-action listener: _resource_record_pre_action 05:52:54 INFO - Running main action method: download_and_extract 05:52:54 INFO - mkdir: /builds/slave/test/build/tests 05:52:54 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')]} 05:52:54 INFO - trying https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:52:54 INFO - Downloading https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:52:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:52:55 INFO - Downloaded 1361 bytes. 05:52:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 05:52:55 INFO - Using the following test package requirements: 05:52:55 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'jsshell-linux-x86_64.zip'], 05:52:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:55 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:55 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:52:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:55 INFO - Http code: 200 05:52:55 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 05:52:55 INFO - x-amz-cf-id: _mwHmZiCzb00fVWsq6dq3pRhfqA-kIZleurm-3-EJT3o1IZQ2ZGVSw== 05:52:55 INFO - x-amz-version-id: v2D.DN.cPiQ4ZcDxUTIFUGvkzYQ4d8Pl 05:52:56 INFO - Expected file size: 21780521 05:52:56 INFO - Obtained file size: 21780521 05:53:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:53:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 05:53:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:53:00 INFO - Http code: 200 05:53:00 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:53:00 INFO - x-amz-cf-id: 67HmcPckamhllXbYFO8YziqrtWHVowSh-xQDnJttc2IA9BfXwuSvdQ== 05:53:00 INFO - x-amz-version-id: v2D.DN.cPiQ4ZcDxUTIFUGvkzYQ4d8Pl 05:53:00 INFO - Expected file size: 21780521 05:53:00 INFO - Obtained file size: 21780521 05:53:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:53:05 INFO - Fetch https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:53:05 INFO - Http code: 200 05:53:05 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 05:53:05 INFO - x-amz-cf-id: 36x39E3NSTGnAPJjKPtpkFik04_HC89eJIrKACB6Woe_9ueneGdyJw== 05:53:05 INFO - x-amz-version-id: l5HV27tXmCKEnZlWE1GZwkGHug7Eg1g3 05:53:06 INFO - Expected file size: 14409702 05:53:06 INFO - Obtained file size: 14409702 05:53:07 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')]} 05:53:07 INFO - trying https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:53:07 INFO - Downloading https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:53:10 INFO - Downloaded 59821453 bytes. 05:53:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:53:10 INFO - mkdir: /builds/slave/test/properties 05:53:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:10 INFO - Contents: 05:53:10 INFO - build_url:https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 05:53:11 INFO - Running post-action listener: _resource_record_post_action 05:53:11 INFO - Running post-action listener: set_extra_try_arguments 05:53:11 INFO - [mozharness: 2016-11-28 13:53:11.389772Z] Finished download-and-extract step (success) 05:53:11 INFO - [mozharness: 2016-11-28 13:53:11.389996Z] Running populate-webroot step. 05:53:11 INFO - Running pre-action listener: _resource_record_pre_action 05:53:11 INFO - Running main action method: populate_webroot 05:53:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:11 INFO - '--tppagecycles', 05:53:11 INFO - '7'], 05:53:11 INFO - 'tests': ['tsvgm']}}, 05:53:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['damp', 'tps']}, 05:53:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'tests': ['damp', 'tps']}, 05:53:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['dromaeo_dom']}, 05:53:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['basic_compositor_video']}, 05:53:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['a11yr', 05:53:11 INFO - 'ts_paint', 05:53:11 INFO - 'tpaint', 05:53:11 INFO - 'sessionrestore', 05:53:11 INFO - 'sessionrestore_no_auto_restore', 05:53:11 INFO - 'tabpaint']}, 05:53:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:11 INFO - 'ts_paint', 05:53:11 INFO - 'tpaint', 05:53:11 INFO - 'sessionrestore', 05:53:11 INFO - 'sessionrestore_no_auto_restore', 05:53:11 INFO - 'tabpaint']}, 05:53:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:11 INFO - 'ts_paint', 05:53:11 INFO - 'tpaint', 05:53:11 INFO - 'sessionrestore', 05:53:11 INFO - 'sessionrestore_no_auto_restore', 05:53:11 INFO - 'tabpaint']}, 05:53:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:11 INFO - 'ts_paint', 05:53:11 INFO - 'tpaint', 05:53:11 INFO - 'sessionrestore', 05:53:11 INFO - 'sessionrestore_no_auto_restore', 05:53:11 INFO - 'tabpaint']}, 05:53:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['a11yr', 05:53:11 INFO - 'ts_paint', 05:53:11 INFO - 'tpaint', 05:53:11 INFO - 'sessionrestore', 05:53:11 INFO - 'sessionrestore_no_auto_restore', 05:53:11 INFO - 'tabpaint']}, 05:53:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['a11yr', 05:53:11 INFO - 'ts_paint', 05:53:11 INFO - 'tpaint', 05:53:11 INFO - 'sessionrestore', 05:53:11 INFO - 'sessionrestore_no_auto_restore', 05:53:11 INFO - 'tabpaint']}, 05:53:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['tsvgx', 05:53:11 INFO - 'tsvgr_opacity', 05:53:11 INFO - 'tart', 05:53:11 INFO - 'tscrollx', 05:53:11 INFO - 'cart', 05:53:11 INFO - 'tsvg_static']}, 05:53:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:11 INFO - 'tsvgr_opacity', 05:53:11 INFO - 'tart', 05:53:11 INFO - 'tscrollx', 05:53:11 INFO - 'cart', 05:53:11 INFO - 'tsvg_static']}, 05:53:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'talos_options': ['--disable-e10s'], 05:53:11 INFO - 'tests': ['tp5o']}, 05:53:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:53:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'talos_options': ['--disable-e10s', 05:53:11 INFO - '--xperf_path', 05:53:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:11 INFO - 'tests': ['tp5n']}, 05:53:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:53:11 INFO - 'talos_options': ['--xperf_path', 05:53:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:11 INFO - 'tests': ['tp5n']}}, 05:53:11 INFO - 'talos.zip': {'path': '', 05:53:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:11 INFO - Running post-action listener: _resource_record_post_action 05:53:11 INFO - [mozharness: 2016-11-28 13:53:11.408784Z] Finished populate-webroot step (success) 05:53:11 INFO - [mozharness: 2016-11-28 13:53:11.408870Z] Running create-virtualenv step. 05:53:11 INFO - Running pre-action listener: _resource_record_pre_action 05:53:11 INFO - Running main action method: create_virtualenv 05:53:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:11 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 05:53:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:11 INFO - Using real prefix '/usr' 05:53:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:13 INFO - Installing pip.................done. 05:53:13 INFO - Return code: 0 05:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:14 INFO - Reading from file tmpfile_stdout 05:53:14 INFO - Output received: 05:53:14 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) 05:53:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:14 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')]} 05:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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')]} 05:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:14 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 05:53:14 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 05:53:14 INFO - Using env: {'DISPLAY': ':0', 05:53:14 INFO - 'HOME': '/home/cltbld', 05:53:14 INFO - 'LANG': 'en_US.UTF-8', 05:53:14 INFO - 'LANGUAGE': 'en_US:en', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MAIL': '/var/mail/cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SHLVL': '1', 05:53:14 INFO - 'TERM': 'linux', 05:53:14 INFO - 'TMOUT': '86400', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - '_': '/tools/buildbot/bin/python'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 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 05:53:14 INFO - Cleaning up... 05:53:14 INFO - Return code: 0 05:53:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:14 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')]} 05:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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')]} 05:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:14 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:14 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 05:53:14 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 05:53:14 INFO - Using env: {'DISPLAY': ':0', 05:53:14 INFO - 'HOME': '/home/cltbld', 05:53:14 INFO - 'LANG': 'en_US.UTF-8', 05:53:14 INFO - 'LANGUAGE': 'en_US:en', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MAIL': '/var/mail/cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SHLVL': '1', 05:53:14 INFO - 'TERM': 'linux', 05:53:14 INFO - 'TMOUT': '86400', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - '_': '/tools/buildbot/bin/python'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Downloading/unpacking psutil>=3.1.1 05:53:14 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 05:53:14 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 05:53:14 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 05:53:14 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 05:53:14 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 05:53:14 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 05:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:16 INFO - Installing collected packages: psutil 05:53:16 INFO - Running setup.py install for psutil 05:53:16 INFO - building 'psutil._psutil_linux' extension 05:53:16 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 05:53:16 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 05:53:16 INFO - building 'psutil._psutil_posix' extension 05:53:16 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 05:53:17 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 05:53:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:17 INFO - Successfully installed psutil 05:53:17 INFO - Cleaning up... 05:53:17 INFO - Return code: 0 05:53:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:17 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')]} 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:17 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')]} 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:17 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:17 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 05:53:17 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 05:53:17 INFO - Using env: {'DISPLAY': ':0', 05:53:17 INFO - 'HOME': '/home/cltbld', 05:53:17 INFO - 'LANG': 'en_US.UTF-8', 05:53:17 INFO - 'LANGUAGE': 'en_US:en', 05:53:17 INFO - 'LOGNAME': 'cltbld', 05:53:17 INFO - 'MAIL': '/var/mail/cltbld', 05:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:17 INFO - 'MOZ_NO_REMOTE': '1', 05:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:17 INFO - 'NO_EM_RESTART': '1', 05:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:17 INFO - 'PWD': '/builds/slave/test', 05:53:17 INFO - 'SHELL': '/bin/bash', 05:53:17 INFO - 'SHLVL': '1', 05:53:17 INFO - 'TERM': 'linux', 05:53:17 INFO - 'TMOUT': '86400', 05:53:17 INFO - 'USER': 'cltbld', 05:53:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:17 INFO - '_': '/tools/buildbot/bin/python'} 05:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:17 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 05:53:17 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 05:53:17 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 05:53:17 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 05:53:17 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 05:53:17 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 05:53:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:19 INFO - Installing collected packages: mozsystemmonitor 05:53:19 INFO - Running setup.py install for mozsystemmonitor 05:53:19 INFO - Successfully installed mozsystemmonitor 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:19 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 05:53:19 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 05:53:19 INFO - Using env: {'DISPLAY': ':0', 05:53:19 INFO - 'HOME': '/home/cltbld', 05:53:19 INFO - 'LANG': 'en_US.UTF-8', 05:53:19 INFO - 'LANGUAGE': 'en_US:en', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MAIL': '/var/mail/cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SHLVL': '1', 05:53:19 INFO - 'TERM': 'linux', 05:53:19 INFO - 'TMOUT': '86400', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - '_': '/tools/buildbot/bin/python'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:19 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 05:53:19 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 05:53:19 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 05:53:19 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 05:53:19 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 05:53:19 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 05:53:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:21 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 05:53:21 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 05:53:21 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 05:53:21 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 05:53:21 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 05:53:21 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 05:53:22 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:22 INFO - warning: no files found matching '*.txt' 05:53:22 INFO - no previously-included directories found matching 'build' 05:53:22 INFO - no previously-included directories found matching 'dist' 05:53:22 INFO - no previously-included directories found matching '.git*' 05:53:22 INFO - Installing collected packages: jsonschema, functools32 05:53:22 INFO - Running setup.py install for functools32 05:53:22 INFO - warning: no files found matching '*.txt' 05:53:22 INFO - no previously-included directories found matching 'build' 05:53:22 INFO - no previously-included directories found matching 'dist' 05:53:22 INFO - no previously-included directories found matching '.git*' 05:53:22 INFO - Successfully installed jsonschema functools32 05:53:22 INFO - Cleaning up... 05:53:22 INFO - Return code: 0 05:53:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:22 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')]} 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 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')]} 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:22 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 05:53:22 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 05:53:22 INFO - Using env: {'DISPLAY': ':0', 05:53:22 INFO - 'HOME': '/home/cltbld', 05:53:22 INFO - 'LANG': 'en_US.UTF-8', 05:53:22 INFO - 'LANGUAGE': 'en_US:en', 05:53:22 INFO - 'LOGNAME': 'cltbld', 05:53:22 INFO - 'MAIL': '/var/mail/cltbld', 05:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:22 INFO - 'MOZ_NO_REMOTE': '1', 05:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:22 INFO - 'NO_EM_RESTART': '1', 05:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:22 INFO - 'PWD': '/builds/slave/test', 05:53:22 INFO - 'SHELL': '/bin/bash', 05:53:22 INFO - 'SHLVL': '1', 05:53:22 INFO - 'TERM': 'linux', 05:53:22 INFO - 'TMOUT': '86400', 05:53:22 INFO - 'USER': 'cltbld', 05:53:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:22 INFO - '_': '/tools/buildbot/bin/python'} 05:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:22 INFO - Cleaning up... 05:53:22 INFO - Return code: 0 05:53:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:22 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')]} 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 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')]} 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:22 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 05:53:22 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 05:53:22 INFO - Using env: {'DISPLAY': ':0', 05:53:22 INFO - 'HOME': '/home/cltbld', 05:53:22 INFO - 'LANG': 'en_US.UTF-8', 05:53:22 INFO - 'LANGUAGE': 'en_US:en', 05:53:22 INFO - 'LOGNAME': 'cltbld', 05:53:22 INFO - 'MAIL': '/var/mail/cltbld', 05:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:22 INFO - 'MOZ_NO_REMOTE': '1', 05:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:22 INFO - 'NO_EM_RESTART': '1', 05:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:22 INFO - 'PWD': '/builds/slave/test', 05:53:22 INFO - 'SHELL': '/bin/bash', 05:53:22 INFO - 'SHLVL': '1', 05:53:22 INFO - 'TERM': 'linux', 05:53:22 INFO - 'TMOUT': '86400', 05:53:22 INFO - 'USER': 'cltbld', 05:53:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:22 INFO - '_': '/tools/buildbot/bin/python'} 05:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:22 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 05:53:22 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 05:53:22 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 05:53:22 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 05:53:22 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 05:53:22 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 05:53:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:24 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 05:53:24 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 05:53:24 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 05:53:24 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 05:53:24 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 05:53:24 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 05:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:25 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 05:53:25 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 05:53:25 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 05:53:25 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 05:53:25 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 05:53:25 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 05:53:25 INFO - Downloading docopt-0.6.1.tar.gz 05:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:25 INFO - Running setup.py install for blobuploader 05:53:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:25 INFO - Running setup.py install for requests 05:53:25 INFO - Running setup.py install for docopt 05:53:26 INFO - Successfully installed blobuploader requests docopt 05:53:26 INFO - Cleaning up... 05:53:26 INFO - Return code: 0 05:53:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:26 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:26 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 05:53:26 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 05:53:26 INFO - Using env: {'DISPLAY': ':0', 05:53:26 INFO - 'HOME': '/home/cltbld', 05:53:26 INFO - 'LANG': 'en_US.UTF-8', 05:53:26 INFO - 'LANGUAGE': 'en_US:en', 05:53:26 INFO - 'LOGNAME': 'cltbld', 05:53:26 INFO - 'MAIL': '/var/mail/cltbld', 05:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:26 INFO - 'MOZ_NO_REMOTE': '1', 05:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:26 INFO - 'NO_EM_RESTART': '1', 05:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:26 INFO - 'PWD': '/builds/slave/test', 05:53:26 INFO - 'SHELL': '/bin/bash', 05:53:26 INFO - 'SHLVL': '1', 05:53:26 INFO - 'TERM': 'linux', 05:53:26 INFO - 'TMOUT': '86400', 05:53:26 INFO - 'USER': 'cltbld', 05:53:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:26 INFO - '_': '/tools/buildbot/bin/python'} 05:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:26 INFO - Running setup.py (path:/tmp/pip-LhEy1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:26 INFO - Running setup.py (path:/tmp/pip-7IUHlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:26 INFO - Running setup.py (path:/tmp/pip-Dwm_Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:26 INFO - Running setup.py (path:/tmp/pip-5SEaro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:26 INFO - Running setup.py (path:/tmp/pip-HYUCpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:26 INFO - Running setup.py (path:/tmp/pip-OSQcC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:26 INFO - Running setup.py (path:/tmp/pip-DOPKII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:26 INFO - Running setup.py (path:/tmp/pip-tku2sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:26 INFO - Running setup.py (path:/tmp/pip-hSlbUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:26 INFO - Running setup.py (path:/tmp/pip-nlD4Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:27 INFO - Running setup.py (path:/tmp/pip-z9BZIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:27 INFO - Running setup.py (path:/tmp/pip-iTp6_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:27 INFO - Running setup.py (path:/tmp/pip-3q0C4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:27 INFO - Running setup.py (path:/tmp/pip-AKBYoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:27 INFO - Running setup.py (path:/tmp/pip-okcZE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:27 INFO - Running setup.py (path:/tmp/pip-k2R0Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:27 INFO - Running setup.py (path:/tmp/pip-At7_Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:27 INFO - Running setup.py install for manifestparser 05:53:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:27 INFO - Running setup.py install for mozcrash 05:53:27 INFO - Running setup.py install for mozdebug 05:53:27 INFO - Running setup.py install for mozdevice 05:53:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:27 INFO - Running setup.py install for mozfile 05:53:28 INFO - Running setup.py install for mozhttpd 05:53:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Running setup.py install for mozinfo 05:53:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Running setup.py install for mozInstall 05:53:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Running setup.py install for mozleak 05:53:28 INFO - Running setup.py install for mozlog 05:53:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Running setup.py install for moznetwork 05:53:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Running setup.py install for mozprocess 05:53:28 INFO - Running setup.py install for mozprofile 05:53:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:28 INFO - Running setup.py install for mozrunner 05:53:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:29 INFO - Running setup.py install for mozscreenshot 05:53:29 INFO - Running setup.py install for moztest 05:53:29 INFO - Running setup.py install for mozversion 05:53:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:29 INFO - Cleaning up... 05:53:29 INFO - Return code: 0 05:53:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:29 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')]} 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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')]} 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:29 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 05:53:29 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 05:53:29 INFO - Using env: {'DISPLAY': ':0', 05:53:29 INFO - 'HOME': '/home/cltbld', 05:53:29 INFO - 'LANG': 'en_US.UTF-8', 05:53:29 INFO - 'LANGUAGE': 'en_US:en', 05:53:29 INFO - 'LOGNAME': 'cltbld', 05:53:29 INFO - 'MAIL': '/var/mail/cltbld', 05:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:29 INFO - 'MOZ_NO_REMOTE': '1', 05:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:29 INFO - 'NO_EM_RESTART': '1', 05:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:29 INFO - 'PWD': '/builds/slave/test', 05:53:29 INFO - 'SHELL': '/bin/bash', 05:53:29 INFO - 'SHLVL': '1', 05:53:29 INFO - 'TERM': 'linux', 05:53:29 INFO - 'TMOUT': '86400', 05:53:29 INFO - 'USER': 'cltbld', 05:53:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:29 INFO - '_': '/tools/buildbot/bin/python'} 05:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:29 INFO - Running setup.py (path:/tmp/pip-0bVlSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:29 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)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:29 INFO - Running setup.py (path:/tmp/pip-6z5hXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:29 INFO - Running setup.py (path:/tmp/pip-5Te1LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:29 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)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:29 INFO - Running setup.py (path:/tmp/pip-fo0pQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:29 INFO - Running setup.py (path:/tmp/pip-TIFoWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:29 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)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:29 INFO - Running setup.py (path:/tmp/pip-MW5laR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:30 INFO - Running setup.py (path:/tmp/pip-2ZRtVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:30 INFO - Running setup.py (path:/tmp/pip-duFBsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:30 INFO - Running setup.py (path:/tmp/pip-Zuq1iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:30 INFO - Running setup.py (path:/tmp/pip-mmsG31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:30 INFO - Running setup.py (path:/tmp/pip-KfuIVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:30 INFO - Running setup.py (path:/tmp/pip-cGDlgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:30 INFO - Running setup.py (path:/tmp/pip-SARnqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:30 INFO - Running setup.py (path:/tmp/pip-WKok0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:30 INFO - Running setup.py (path:/tmp/pip-DzscoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:30 INFO - Running setup.py (path:/tmp/pip-zz2MmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:30 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)) 05:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:30 INFO - Running setup.py (path:/tmp/pip-8_6HhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:30 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)) 05:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:30 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)) 05:53:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:30 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:30 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 05:53:30 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 05:53:30 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 05:53:30 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 05:53:30 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 05:53:30 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 05:53:32 INFO - Downloading blessings-1.6.tar.gz 05:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:32 INFO - Installing collected packages: blessings 05:53:32 INFO - Running setup.py install for blessings 05:53:32 INFO - Successfully installed blessings 05:53:32 INFO - Cleaning up... 05:53:33 INFO - Return code: 0 05:53:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:33 INFO - Reading from file tmpfile_stdout 05:53:33 INFO - Current package versions: 05:53:33 INFO - argparse == 1.2.1 05:53:33 INFO - blessings == 1.6 05:53:33 INFO - blobuploader == 1.2.4 05:53:33 INFO - docopt == 0.6.1 05:53:33 INFO - functools32 == 3.2.3-2 05:53:33 INFO - jsonschema == 2.5.1 05:53:33 INFO - manifestparser == 1.1 05:53:33 INFO - mozInstall == 1.12 05:53:33 INFO - mozcrash == 1.0 05:53:33 INFO - mozdebug == 0.1 05:53:33 INFO - mozdevice == 0.49 05:53:33 INFO - mozfile == 1.2 05:53:33 INFO - mozhttpd == 0.7 05:53:33 INFO - mozinfo == 0.9 05:53:33 INFO - mozleak == 0.1 05:53:33 INFO - mozlog == 3.4 05:53:33 INFO - moznetwork == 0.27 05:53:33 INFO - mozprocess == 0.23 05:53:33 INFO - mozprofile == 0.28 05:53:33 INFO - mozrunner == 6.13 05:53:33 INFO - mozscreenshot == 0.1 05:53:33 INFO - mozsystemmonitor == 0.3 05:53:33 INFO - moztest == 0.7 05:53:33 INFO - mozversion == 1.4 05:53:33 INFO - psutil == 3.1.1 05:53:33 INFO - requests == 1.2.3 05:53:33 INFO - wsgiref == 0.1.2 05:53:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:33 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 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53:33 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 05:53:33 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 05:53:33 INFO - Using env: {'DISPLAY': ':0', 05:53:33 INFO - 'HOME': '/home/cltbld', 05:53:33 INFO - 'LANG': 'en_US.UTF-8', 05:53:33 INFO - 'LANGUAGE': 'en_US:en', 05:53:33 INFO - 'LOGNAME': 'cltbld', 05:53:33 INFO - 'MAIL': '/var/mail/cltbld', 05:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:33 INFO - 'MOZ_NO_REMOTE': '1', 05:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:33 INFO - 'NO_EM_RESTART': '1', 05:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:33 INFO - 'PWD': '/builds/slave/test', 05:53:33 INFO - 'SHELL': '/bin/bash', 05:53:33 INFO - 'SHLVL': '1', 05:53:33 INFO - 'TERM': 'linux', 05:53:33 INFO - 'TMOUT': '86400', 05:53:33 INFO - 'USER': 'cltbld', 05:53:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:33 INFO - '_': '/tools/buildbot/bin/python'} 05:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 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)) 05:53:33 INFO - Cleaning up... 05:53:33 INFO - Return code: 0 05:53:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c6346ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1138130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', '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 05:53: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', 'jsonschema'] in /builds/slave/test/build 05:53: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 jsonschema 05:53:33 INFO - Using env: {'DISPLAY': ':0', 05:53:33 INFO - 'HOME': '/home/cltbld', 05:53:33 INFO - 'LANG': 'en_US.UTF-8', 05:53:33 INFO - 'LANGUAGE': 'en_US:en', 05:53:33 INFO - 'LOGNAME': 'cltbld', 05:53:33 INFO - 'MAIL': '/var/mail/cltbld', 05:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:33 INFO - 'MOZ_NO_REMOTE': '1', 05:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:33 INFO - 'NO_EM_RESTART': '1', 05:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:33 INFO - 'PWD': '/builds/slave/test', 05:53:33 INFO - 'SHELL': '/bin/bash', 05:53:33 INFO - 'SHLVL': '1', 05:53:33 INFO - 'TERM': 'linux', 05:53:33 INFO - 'TMOUT': '86400', 05:53:33 INFO - 'USER': 'cltbld', 05:53:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:33 INFO - '_': '/tools/buildbot/bin/python'} 05:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:33 INFO - Cleaning up... 05:53:33 INFO - Return code: 0 05:53:33 INFO - Running post-action listener: _resource_record_post_action 05:53:33 INFO - Running post-action listener: _start_resource_monitoring 05:53:33 INFO - Starting resource monitoring. 05:53:33 INFO - [mozharness: 2016-11-28 13:53:33.759267Z] Finished create-virtualenv step (success) 05:53:33 INFO - [mozharness: 2016-11-28 13:53:33.759791Z] Running install step. 05:53:33 INFO - Running pre-action listener: _resource_record_pre_action 05:53:33 INFO - Running main action method: install 05:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:33 INFO - Reading from file tmpfile_stdout 05:53:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:34 INFO - Reading from file tmpfile_stdout 05:53:34 INFO - Output received: 05:53:34 INFO - Usage: mozinstall [options] installer 05:53:34 INFO - Options: 05:53:34 INFO - -h, --help show this help message and exit 05:53:34 INFO - -d DEST, --destination=DEST 05:53:34 INFO - Directory to install application into. [default: 05:53:34 INFO - "/builds/slave/test"] 05:53:34 INFO - --app=APP Application being installed. [default: firefox] 05:53:34 INFO - mkdir: /builds/slave/test/build/application 05:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:53:51 INFO - Reading from file tmpfile_stdout 05:53:51 INFO - Output received: 05:53:51 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:51 INFO - Running post-action listener: _resource_record_post_action 05:53:51 INFO - [mozharness: 2016-11-28 13:53:51.015914Z] Finished install step (success) 05:53:51 INFO - [mozharness: 2016-11-28 13:53:51.016152Z] Running run-tests step. 05:53:51 INFO - Running pre-action listener: _resource_record_pre_action 05:53:51 INFO - Running main action method: run_tests 05:53:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:51 INFO - Python 2.7.3 05:53:51 INFO - Return code: 0 05:53:51 INFO - grabbing minidump binary from tooltool 05:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:51 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 0x11c6fc0>, '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 0x11c7ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11c8350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:51 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 05:53:51 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 05:53:51 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 05:53:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:51 INFO - Return code: 0 05:53:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 05:53:51 INFO - Using env: {'DISPLAY': ':0', 05:53:51 INFO - 'HOME': '/home/cltbld', 05:53:51 INFO - 'LANG': 'en_US.UTF-8', 05:53:51 INFO - 'LANGUAGE': 'en_US:en', 05:53:51 INFO - 'LOGNAME': 'cltbld', 05:53:51 INFO - 'MAIL': '/var/mail/cltbld', 05:53:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:51 INFO - 'MOZ_NO_REMOTE': '1', 05:53:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:51 INFO - 'NO_EM_RESTART': '1', 05:53:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:51 INFO - 'PWD': '/builds/slave/test', 05:53:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:51 INFO - 'SHELL': '/bin/bash', 05:53:51 INFO - 'SHLVL': '1', 05:53:51 INFO - 'TERM': 'linux', 05:53:51 INFO - 'TMOUT': '86400', 05:53:51 INFO - 'USER': 'cltbld', 05:53:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483', 05:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:51 INFO - '_': '/tools/buildbot/bin/python'} 05:53:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:53:51 INFO - mozversion application_buildid: 20161128030212 05:53:51 INFO - mozversion application_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 05:53:51 INFO - mozversion application_display_name: Nightly 05:53:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:51 INFO - mozversion application_name: Firefox 05:53:51 INFO - mozversion application_remotingname: firefox 05:53:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:51 INFO - mozversion application_vendor: Mozilla 05:53:51 INFO - mozversion application_version: 53.0a1 05:53:51 INFO - mozversion platform_buildid: 20161128030212 05:53:51 INFO - mozversion platform_changeset: 05328d3102efd4d5fc0696489734d7771d24459f 05:53:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:51 INFO - mozversion platform_version: 53.0a1 05:53:51 INFO - using testdate: 1480341231 05:53:51 INFO - actual date: 1480341231 05:53:51 INFO - starting webserver on 'localhost:34316' 05:53:51 INFO - SUITE-START | Running 2 tests 05:53:51 INFO - TEST-START | dromaeo_css 05:53:51 INFO - operating with platform_type : linux_ 05:53:51 INFO - Initialising browser for dromaeo_css test... 05:53:51 INFO - TEST-INFO | started process 29333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc8q4cm/profile http://localhost:34316/getInfo.html) 05:53:55 INFO - PROCESS | 29333 | __metrics Screen width/height:1600/1200 05:53:55 INFO - PROCESS | 29333 | colorDepth:24 05:53:55 INFO - PROCESS | 29333 | Browser inner width/height: 1024/697 05:53:55 INFO - PROCESS | 29333 | __metrics 05:53:56 INFO - PROCESS | 29333 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:56 INFO - PROCESS | 29333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:56 INFO - PROCESS | 29333 | console.error: PushService: 05:53:56 INFO - PROCESS | 29333 | stateChangeProcessEnqueue: Error transitioning state 05:53:56 INFO - PROCESS | 29333 | UnknownError 05:53:57 INFO - TEST-INFO | 29333: exit 0 05:53:57 INFO - Browser initialized. 05:53:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:57 INFO - TEST-INFO | started process 29418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc8q4cm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:09 INFO - PROCESS | 29418 | RSS: Main: 173363200 05:54:09 INFO - PROCESS | 29418 | 05:55:01 INFO - PROCESS | 29418 | 1480341301296 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] 05:57:12 INFO - PROCESS | 29418 | Cycle 1(1): loaded http://localhost:34316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34316/tests/dromaeo/cssquery-ext.html) 05:57:14 INFO - PROCESS | 29418 | RSS: Main: 302411776 05:57:14 INFO - PROCESS | 29418 | 06:00:16 INFO - PROCESS | 29418 | Cycle 1(1): loaded http://localhost:34316/tests/dromaeo/cssquery-ext.html (next: http://localhost:34316/tests/dromaeo/cssquery-jquery.html) 06:00:17 INFO - PROCESS | 29418 | RSS: Main: 287899648 06:00:17 INFO - PROCESS | 29418 | 06:03:19 INFO - PROCESS | 29418 | Cycle 1(1): loaded http://localhost:34316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34316/tests/dromaeo/cssquery-mootools.html) 06:03:20 INFO - PROCESS | 29418 | RSS: Main: 220930048 06:03:20 INFO - PROCESS | 29418 | 06:06:22 INFO - PROCESS | 29418 | Cycle 1(1): loaded http://localhost:34316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34316/tests/dromaeo/cssquery-prototype.html) 06:06:22 INFO - PROCESS | 29418 | RSS: Main: 221872128 06:06:22 INFO - PROCESS | 29418 | 06:09:25 INFO - PROCESS | 29418 | Cycle 1(1): loaded http://localhost:34316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34316/tests/dromaeo/cssquery-yui.html) 06:09:26 INFO - PROCESS | 29418 | RSS: Main: 221638656 06:09:26 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | Cycle 1(1): loaded http://localhost:34316/tests/dromaeo/cssquery-yui.html (next: http://localhost:34316/tests/dromaeo/cssquery-dojo.html) 06:12:29 INFO - PROCESS | 29418 | RSS: Main: 298520576 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | __start_tp_report 06:12:29 INFO - PROCESS | 29418 | _x_x_mozilla_page_load 06:12:29 INFO - PROCESS | 29418 | _x_x_mozilla_page_load_details 06:12:29 INFO - PROCESS | 29418 | |i|pagename|runs| 06:12:29 INFO - PROCESS | 29418 | |0;dojo.html;3111.39327831073;3138.827364494953;3144.3082521845186;3174.476211425115;3187.9043628691147;5274.156135018397;5331.7334133293325;5365.087935051041;5455.809046683366;5459.372172200198;5339.145736682131;5355.812546560871;5392.110301800208;5399.244105825188;5516.007118718629;4907.312976183337;4962.801487940496;4975.477574854643;4977.0792403405485;4985.850424487262;4968.478309777475;4993.450720420751;5005.224190250517;5050;5064.341635587387;4965.379327584052;5019.297298378212;5038.294638750578;5064.442911279774;5085.618578606601;4713.505081966413;4736.2895565665085;4738.147133515966;4837.492063333335;4954.479779623124;4795.4964728703335;4797.0166115946495;4799.18413869643;4804.519548045202;4810.350602668665;5179.041877252683;5207.010667973073;5232.39827419844;5233.659812112201;5240.213967904845;5606.6636001840025;5615.354234263071;5615.494605485526;5618.690971996539;5618.747156377973;5654.971725141348;5665.348484924245;5671.092625179951;5671.120976248688;5673.3475650299915;5396.892062158774;5399.70301633414;5412.242286079952;5415.891682166334;5417.295751552273;5841.561882858802;5878.882422351529;5891.499222566044;5896.262967129109;5897.439743224387;5729.627574207663;5735.0250457422335;5735.340435849847;5740.770369185186;5744.971275143597;5593.636413633182;5637.520810731134;5840.386759390203;5841.299044114733;5845.210896528914;5700.914486282709;5703.201551782754;5708.343540492813;5709.371969083398;5712.0860662293835;5720.48515633595;5720.713964301768;5727.026405511073;5727.140928860621;5731.226284451629;4426.513083560806;4445.799939002753;4456.264716321835;4473.753943533072;4518.683692141584;4011.638952494231;4035.6569691576547;4035.6771458283265;4072.7963601819793;4076.571959944163;5247.396549396868;5519.061759500814;5519.2824932758485;5520;5521.668699878021;5694.886102277931;5798.82603521895;5827.125931110282;5843.883122337529;5868.853278668067;5570.248016517799;5577.553795696334;5579.9163012554845;5587.497125258665;5611.6352437091455;5046.293518907356;5057.69653820772;5103.413107492686;5108.182690769459;5154.7164905929785;5798.217240672455;5840.883182336414;5920.644761314335;5964.671943043;6021.367756385516;5882.352941176553;5886.205362276038;5888.440598143169;5920.348761636303;5940.495057919952;6048.637081775108;6050.606710563799;6054.939450605438;6057.697115144313;6064.636121832704;5563.471470210324;5574.108142697149;5597.524210441995;5759.193712880284;5771.509421699203;5732.369439361583;5761.769529218785;5820.214271073351;5849.122631605123;5862.589618726648;5606.495415412633;5631.63394379364;5638.60529762929;5640.435956404327;5641.717914104361;5466.289382380265;5476.698781567052;5660.603757736919;5664.546836253007;5668.801591944262;5642;5646;5659.886802264014;5686.60193786431;5782.624129431573;5736.913946290892;5769.249997500298;5778.27771528559;5780.797672081457;5782.971085144715;5445.646033007842;5648.293963254593;5658.349289831722;5661.575381846295;5663.9716801415725 06:12:29 INFO - PROCESS | 29418 | |1;ext.html;541.3134511285874;583.8190161050074;597.5219824140686;624.4161708802268;643.7328508668903;31703;34437;34445.82777086117;34451;34481.82759086204;34270.48594271088;41734.58265417345;42861.571384286224;42930;45714;8506.106858779833;8638.222559969601;8640.308775297992;8642.049374568793;8642.351823613222;7915.485493442937;8526.70156544521;8614.483131012128;8621.396502244814;8629.309655227598;7980.082290536576;10164.64423745169;10372.325798823053;10392.584296628163;10717.142628589732;10240.74398140045;10305.227107966932;10309.072183503446;10314.12329951955;10380.169586433067;9990.250731195189;10052.497375131214;10055.497225138786;10067.345622534513;10073.24450666203;39294.60705392938;39681.80159099186;39683.8015809922;39701.40447893284;39745.20509589792;3406.5741782277214;3534.3024967686347;3563.6436356364156;3838.6161383861668;3920.0003998980364;30754.692453075408;31196.376072478422;31634;31656.36687266265;31692.524612130837;4117.402976568381;4182.1008483176265;4256.659467242614;4295.763732994684;4397.582229688206;325375.9999999976;326876;327635;328083;329447;58359;58762.41237587655;58766;58780.70609646924;58807.411925881046;60110;60530;60679;60694.69652651797;60695.393046069854;14790.704185916222;15188.46840360582;15190.696186076217;15199.164045977577;15211.315490802941;11679.182457227913;11751;11751.294922304689;11755.529778808752;11760.470778814974;15950.840491595167;16211;17710.822891771175;18165.182566784526;18235.54411139732;5752.36723960364;6038.607490513103;6048.727807248684;6075.939240607626;6085;940.3652534539159;987.5555999800118;1033.7415646088477;1038.314712289885;1128.7347473343757;31656.841715791274;31769.20576985594;31831;32074.83962580219;32334.676653233637;1025.5180065369264;1096.873859506167;1137.9829302560302;1150.5847807197026;1194.7670204310075;15906;16472.505824825275;16676.33294668224;16754.497365079067;16765.7485137723;476552;479089;480939;481599;483328;49574.25638615424;50307.24539131916;54633.45366546363;56416.43583564194;56624.150637740466;1319.920804751718;1342.5166939901824;1344.1128854955878;1352.2697743218946;1360.2314692199075;30721.53917691281;33073.33853322968;33202.833985829915;33244.50133247955;33474.66525334716;50426.2436063452;50755.492445076554;50961.23558146705;51004.489955099976;51005.74497127491;389631;393246;419972;433181;436900;27129.72870271272;27801.165965021082;27815;27943.58084628773;28147.57778633363;46283.3057504131;46512.25572291931;46576;46716.299255510516;46805;38553.61446385612;39355.80322098371;39828;40035.1992960145;41268.79365603153;39376;39622.40566391564;40022.39966400564;40385.798071009456;40764;39411.802940985115;39597.40603890886;40106.39840402455;40879.386809198484;43803;32054;35664;35886.59077387644;36560.81719591385;36576;27194.592081118404;27619;27665.446691066467;27921.44157116887;27930.441391171655 06:12:29 INFO - PROCESS | 29418 | |2;jquery.html;379.72469959279545;397.439610149689;403.8828739665497;410.82950575511154;421.466844441781;13593.592192234237;15655.765163522556;18943.242270309172;19002.334918277862;19111.235550577996;18134.455966321;18728.625427491443;18836;19253.422397328104;19255.229790808386;4607.239805432099;5470;5738.512226460735;5743.368229494752;5746.48281654651;5573.219749235111;5626.409227031164;5666.46168613981;5670.404607516213;5671.489565939065;5489.835304940858;5538.778448862041;5679;5690.459406356389;5694.316681998166;5584.52531534818;5604.495595396414;5640.182173584807;5641.069223578104;5643.999999999979;4926.630502712275;5015.14742493777;5053.620978426633;5068.670536415121;5071.442141364447;21599.784002159933;22036.779632203634;22402.327930162122;22572.322830315115;22914.770852291596;2378.9167379141645;2391.557561851063;2431.6838810954464;2599.038355808344;2734.1934129431866;13981.79027314591;14143.717125657533;14193.574192774233;14300.141991480545;14322.856771432256;1810.1582764014797;1828.4240464253717;1832.8533717302716;1852.555386707194;1948.0357223174478;59626;79628;79941.60029199875;81233;83098.58450707768;10408.583656653649;10486.73783155412;10578.889216632297;10666;10889.074428673652;14818.851811481964;14846.18345990981;14920.925395373171;14925.850741492663;14948.103113813206;7156.856862862714;7349.280766116464;7471.364933980563;7624.923750762532;7663.8850417242675;6856.348646878539;6875.862482750417;7056.717731290691;7103.715851365991;7118.679659415338;6480.967595162088;6496.577722448026;6530.640814755139;6553.672316384162;6634.601923884582;1788.4098247578268;1859.7768267807949;1874.137896567567;1918.894460804669;1990.2735501541833;726.8987483961802;933.7432206143365;959.8176346494143;995.7958618483193;997.2221667099674;19474.902625486782;20022;20150.596988060155;20252.797472025384;20523.692144617842;966.2752935298527;967.9370840895319;983.4640121133999;997.1972562087444;1011.838105903052;10603;11327.093832493381;11380.260283081574;11388.088952883749;11441.771164576829;441339;441553;448112;448840;451049;57806.42193578094;59049.70475147597;76999;77538.6123069381;80440;998.0219385002738;1010.9443980581138;1017.343813240441;1035.0580971316067;1038.6520515627199;16336.509904702878;16648.3340666372;17431.302747889942;17531.123443827502;17968;39571.60428395679;39680.80159599299;40054.59945400509;40547.59452405438;41250;50913.49086509088;51964;52504.73747631237;52686.473135268156;53834.192487113505;7141.85716285661;7906.7627971160955;8026.989878795452;8068.556229407439;8388.412811103164;10889.891101088888;12378.319192444142;12387.814182787446;12405.689857753629;12948.93525532404;5574.052411090205;6819;9670;10800.945995269973;11146.88853111491;10630.946845265724;10696.62561810333;10713.464326783786;10791.56833726642;10934.398608076313;10970.725731856448;11050.723731906444;11155.330680159217;11314.321140731583;11429.657110286706;7432.962835185789;7483.476156668981;7624.123225829101;7829.177936316605;7845.3723702104835;10199.898001019896;10868.891311086787;10906.34561926287;10934.562617495529;11116.110711142928 06:12:29 INFO - PROCESS | 29418 | |3;mootools.html;1410.4851729118868;1464.641162915086;1544.5675210940933;1668.2576253567167;1714.5884987602979;7583.165851756303;7748.225177482249;8075.9192408075905;8639.784005399868;8642.611082501287;8021.438499305051;8286.129956354587;8311.376646751487;8525.531095789729;8537.2743316818;2207.8233741300655;2270.909163633453;2271.1823743452346;2272.6704627828954;2273.227102785061;1995.8103980121866;2035.1655821113347;2258.6837842702034;2281.7490076091617;2339.8128149748063;2040.7653119891254;2059.3307175168056;2059.70134330522;2142.700021996922;2226.510167763098;2193.8793366364844;2198.5712786006734;2200.9119635214574;2201.0975500045065;2202.581509513195;2226.25420484138;2243.4279258788906;2270.0692715986365;2270.0919632147106;2270.14869423966;8519;8558.358123140728;8562.871556926651;8642.30861531076;8651.870221946676;5038.39539255288;5173.249878767558;5178.818741344035;5181.145111056671;5184.377874655028;3198.328351046283;3299.8185099819502;3312.668733126692;3331.1006028372203;3332.6334103248623;1093.3877028863783;1156.404451707363;1178.0752109594014;1186.6914602203403;1207.233406786688;11358.71603209918;11913.285202887855;11948.820767688492;11959.94020029903;11970.760584788342;4296.505901821268;4416.558344165558;4454.37638730578;4460.929376949509;4475.30632751924;9521.190698790542;9539.09378609031;9558;9562;9565.091316324939;5145;5147.510986456281;5148.253503242009;5151.2273159026445;5151.948480515147;4574.588287054181;4682.618627504894;4714.198586240347;4722.763861806896;4772.451168115642;3512.104413374573;3638.2723455308515;3669.1010702377553;3741.7567858089137;3833.846646134179;1140.3955903371227;1150.3155622404656;1174.5301879248198;1178.4225729392535;1195.7429152732204;830.7839961609905;911.3256190419042;917.3761841947539;946.5030858799048;977.1596427072711;5832.504237139806;6022.728977196037;6157.291911430243;6173.536984726164;6350.4602108820345;905.5239958867005;906.9365144439826;967.7822489939848;986.72712201261;1002.9448380339152;3851.9229615407535;4034.152827906114;4051.2707712612014;4206.47419072616;4234.55537168599;9622.422654640604;9964.451955142391;9981.201503879673;10217.540210690388;10243.334183278062;10183.18534517237;10193.949030254802;10202.591896324064;10204.744881378025;10212.234082443847;7761.7671469855995;7930.9603451982375;7933.841323173504;7940.245676660708;7943.920560794434;5462.317210348707;5513.421090785409;5708.257926469532;5787.726700125965;5967.164596956516;9724.95137524308;9730.513474326397;9794.118529332109;9845.950770246103;9851.261155413229;8904.421212621159;9204.677836275698;9240.676576319796;9508.049195080437;9873.851892221479;7508.211637777955;7674.386049116169;7677.731279405418;7689.269519395649;7691;7911.1693272207895;8232.50604963704;8249;8260.091389947222;8268.09051004401;7200.351968322876;7226.74706385274;7271.8909216360735;7335.77992660221;7456.627168641655;7328.157261914948;7424.1462231844025;7478.551286922802;7496.987906632535;7517.511361761687;6593.80218593443;6656.635389745187;6809.795706128824;6811;6813.693383797642;4763.3807605011125;4780.617550596014;4822.541858523435;4867.780949857194;4982.7259500727805;5138.203578445347;5232.442732938994;5264.447233040476;5307.57539396855;5379.704116273486 06:12:29 INFO - PROCESS | 29418 | |4;prototype.html;317.7870826546214;324.2461277529744;326.92644155065113;329.55510061417084;337.85978818790204;5333.706646134461;5372.623916325849;5405.027165084745;5418.837434876955;5459.153831156167;5354.41101478838;5355.651882627626;5379.542738867201;5380.784768609251;5429.56563474922;3981.9800900995456;4066.573009833969;4094.815733292009;4106.3924408000985;4159.500859896817;4145.979270103645;4160.750354978696;4168.499780026386;4176.958230417703;4190.434291370671;4102.159057393227;4129.587041295877;4152.792360381984;4157.833686652531;4168.353905144708;3961.2869683456966;3974.503187101612;4050.129222217223;4155.625993660555;4162.521310049353;3677.3380791457525;3686.3733165361955;3686.9262614747554;3700.296943580738;3740.4950331705145;5158.664686795384;5184.844454666366;5187.48125187482;5187.818426355059;5226.5818734501145;4694.427366832116;4710.24636058229;4756.381670382828;4761.714297142183;4811.398575178103;5511.614187006911;5512.862178445531;5516.338039435253;5517.813670060957;5530.889382212374;4038.7576745395077;4049.1496785675045;4052.7163098582814;4052.9189416211807;4056.1482088761395;5501.504864562168;5747.252857128588;5762.193292938992;5770.884582308372;5805.4194580542035;4148.56440073794;4153.190127925086;4154.584541545822;4156.896077598024;4166.604172603597;4223.260929337353;4248.468941382327;4250.107477429712;4256.191323648497;4257.23369793434;4630.72215667061;4687.156311863897;4742.241241401359;4814.301926220678;4820.9517904821205;5571.470710282517;5584.664920104807;5588.329400471969;5592.972035139798;5600.663960162403;1366.7403193393222;1373.8488766235705;1378.945106993151;1383.7338834965894;1385.4181243877595;943.5188054092463;992.151710287708;995.2237254941158;998.9500524973722;1011.8785745710414;5223.738813059332;5299.735013249322;5310.7610157543;5320.574354051667;5326.866828329323;5597.6641401516035;5663.292088488939;5717.341970828496;5761.711914404263;5801.854953626109;5230.476952304815;5337.466253374709;5403.621746477709;5429.484199001088;5442.374126975369;2896.2614533293877;2909.6577255309257;2933.823970561773;2945.528715405525;2955.852207389622;5740.44550175168;5741.827745167651;5742.942570574241;5749.310082790092;5751.568632352591;5554.333479982347;5656.462636049569;5850.678212698343;5866.178734977107;5873.765049397976;5935.851603709855;5940.168376427304;5940.376260492672;5963.5825492216;5970.253718285215;5608.439156084359;5784.161296611884;5802.533923082758;5809.50619197373;5819.912701309569;5665.66006039639;5672.290963629546;5687.606536398609;5737.799177028784;5746.2529871116485;5857.648541087548;5877.764889404376;5882.882342353215;5968.165121567221;6014.789482368096;3842.442845787289;4006;4022.9597704022585;4030.6372426481757;4038.6970977176243;5687.914681279867;5695.544356451391;5720.342160651412;5742.052561327334;5752.1659359391815;5590.217369568182;5611.943880561143;5612.438756124355;5623.1846382273525;5668.149777533403;5389.59578031657;5600.7199640017025;5623.550115990629;5638.351589567253;5644.745986430538;5631.746571404378;5637.5489960802215;5651.4348565143155;5658.519025882846;5708.885822283614;5452.645578037414;5481.862953426196;5578;5621.662700237999;5653.3781284057895;5531.917021244604;5548.195511650869;5555.111182210827;5560.36055853582;5562.860928476821 06:12:29 INFO - PROCESS | 29418 | |5;yui.html;688.9689963951622;700.4081551089331;727.2836256287558;762.1578156137472;776.7592046465596;15663.451779187732;16503.752443713325;16776.748348774778;16812.66374672506;16934.745978810326;14940.775888361683;15070.321835517401;15225.695486090272;15235;15284.388624455009;663.3996233408749;673.1753601837759;771.3944553525483;781.9296263336298;788.2590365056857;790.0558832195528;803.8593246181924;803.9316658084069;804.1194891593725;804.3565147881701;836.958152092396;840.5965136734371;841.1210285251896;842.4608250719544;842.5744998775609;697.9162500499973;715.8317795318096;805.879118132279;826.7519744076783;833.9583020848963;598.8083813179784;600.7957294519884;602.3945934336008;603.291132918823;603.6951339573532;15554.844451555453;15636.2181890905;15681.451149209837;15681.686366272725;15702.528924132293;14606.12363258208;14642.780358294527;14684.339204735812;14801.779733040023;14863.33115009827;11558.711032224262;11739.128261771355;11832.171747977645;12044.759104817942;12140.757184856342;4212.368144778277;4345.847895323648;4372.475302963633;4382.671299652507;4512.819487220508;83929.58035209785;84813;85169;86473.56763216143;86550.56724716398;11154.832677509843;11252.493637786156;11401.885981140082;11478.439835351497;11519.596814111634;22288.66567001496;22295.665565016538;22305.55388892213;22319.88840055822;22327.21854735109;7828.608569571498;7843.411744119214;7851.685932562747;8086.757397277974;8539.274161696325;4253.63844073251;4444.177827101997;4491.8203271869415;4507.925448528184;4529.660275479287;3296.5055241713453;3345.34765720687;3348.447506161456;3365.4110530657035;3367.124547617637;564.0692856786253;564.297449675157;568.3804652928245;570.2444261353722;574.7930744931821;553.6622660177288;565.527784300114;620.0265583034592;630.817217716781;650.3593959949446;8852.8672069919;9179.77050573741;9281.964959810308;9284.535773211312;9410.529473526296;554.7669978608994;577.9364269930304;634.6097150252654;638.3074364314771;639.4468784501373;4216;4589.54104589545;4590.334401511762;4635.605973492224;4636.4899861015265;68484.3151568488;69497;83408.58295708483;90742.09257907336;93261.5336923311;57838;75418.36035738722;77415;79723.20276797158;80178.32204324754;70026;70925;71511.28488715047;71550.64224678843;73911.26088739152;9068.319876009195;9097.454152750855;9127.406718563272;9139.131782480654;9228.815423691623;39821.40267896042;44217.33673994957;47038.76480617575;47627.76186119047;49740.75129624329;55101.72449137729;55105.17342239789;61274.387256126865;61661.69169154126;63496;12398.318092504998;12411.193272437262;12420.378981051092;12574.685632859251;12972.610821675366;13993.860061399255;14126.576202713935;14284.35720392564;14401.78397324062;15488.5353439397;13621.79567306511;14149.221792801494;14494.202818845064;14838.332275047433;14869.776953345925;13359.599212023655;13849.376558603492;14154.433822646979;14307.499237526637;14412.207328597027;13034.152780069644;13178.275194864374;13453.160943916948;13496.325183740577;13729.656758580715;11238.831417528907;11544.769104618028;11681.357525336189;11875.465604047666;12036.097292703258;10005.791775678408;11246.66260012201;11405.885941140814;11533.135014873751;11751.529938802352 06:12:29 INFO - PROCESS | 29418 | __end_tp_report 06:12:29 INFO - PROCESS | 29418 | __start_cc_report 06:12:29 INFO - PROCESS | 29418 | _x_x_mozilla_cycle_collect,1274 06:12:29 INFO - PROCESS | 29418 | __end_cc_report 06:12:29 INFO - PROCESS | 29418 | __startTimestamp1480342349667__endTimestamp 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | ------- Summary: start ------- 06:12:29 INFO - PROCESS | 29418 | Number of tests: 6 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | [#0] dojo.html Cycles:165 Average:5373.53 Median:5606.66 stddev:596.46 (10.6%) stddev-sans-first:571.28 06:12:29 INFO - PROCESS | 29418 | Values: 3111.4 3138.8 3144.3 3174.5 3187.9 5274.2 5331.7 5365.1 5455.8 5459.4 5339.1 5355.8 5392.1 5399.2 5516.0 4907.3 4962.8 4975.5 4977.1 4985.9 4968.5 4993.5 5005.2 5050.0 5064.3 4965.4 5019.3 5038.3 5064.4 5085.6 4713.5 4736.3 4738.1 4837.5 4954.5 4795.5 4797.0 4799.2 4804.5 4810.4 5179.0 5207.0 5232.4 5233.7 5240.2 5606.7 5615.4 5615.5 5618.7 5618.7 5655.0 5665.3 5671.1 5671.1 5673.3 5396.9 5399.7 5412.2 5415.9 5417.3 5841.6 5878.9 5891.5 5896.3 5897.4 5729.6 5735.0 5735.3 5740.8 5745.0 5593.6 5637.5 5840.4 5841.3 5845.2 5700.9 5703.2 5708.3 5709.4 5712.1 5720.5 5720.7 5727.0 5727.1 5731.2 4426.5 4445.8 4456.3 4473.8 4518.7 4011.6 4035.7 4035.7 4072.8 4076.6 5247.4 5519.1 5519.3 5520.0 5521.7 5694.9 5798.8 5827.1 5843.9 5868.9 5570.2 5577.6 5579.9 5587.5 5611.6 5046.3 5057.7 5103.4 5108.2 5154.7 5798.2 5840.9 5920.6 5964.7 6021.4 5882.4 5886.2 5888.4 5920.3 5940.5 6048.6 6050.6 6054.9 6057.7 6064.6 5563.5 5574.1 5597.5 5759.2 5771.5 5732.4 5761.8 5820.2 5849.1 5862.6 5606.5 5631.6 5638.6 5640.4 5641.7 5466.3 5476.7 5660.6 5664.5 5668.8 5642.0 5646.0 5659.9 5686.6 5782.6 5736.9 5769.2 5778.3 5780.8 5783.0 5445.6 5648.3 5658.3 5661.6 5664.0 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | [#1] ext.html Cycles:180 Average:56693.82 Median:21196.12 stddev:109069.07 (514.6%) stddev-sans-first:109293.56 06:12:29 INFO - PROCESS | 29418 | Values: 541.3 583.8 597.5 624.4 643.7 31703.0 34437.0 34445.8 34451.0 34481.8 34270.5 41734.6 42861.6 42930.0 45714.0 8506.1 8638.2 8640.3 8642.0 8642.4 7915.5 8526.7 8614.5 8621.4 8629.3 7980.1 10164.6 10372.3 10392.6 10717.1 10240.7 10305.2 10309.1 10314.1 10380.2 9990.3 10052.5 10055.5 10067.3 10073.2 39294.6 39681.8 39683.8 39701.4 39745.2 3406.6 3534.3 3563.6 3838.6 3920.0 30754.7 31196.4 31634.0 31656.4 31692.5 4117.4 4182.1 4256.7 4295.8 4397.6 325376.0 326876.0 327635.0 328083.0 329447.0 58359.0 58762.4 58766.0 58780.7 58807.4 60110.0 60530.0 60679.0 60694.7 60695.4 14790.7 15188.5 15190.7 15199.2 15211.3 11679.2 11751.0 11751.3 11755.5 11760.5 15950.8 16211.0 17710.8 18165.2 18235.5 5752.4 6038.6 6048.7 6075.9 6085.0 940.4 987.6 1033.7 1038.3 1128.7 31656.8 31769.2 31831.0 32074.8 32334.7 1025.5 1096.9 1138.0 1150.6 1194.8 15906.0 16472.5 16676.3 16754.5 16765.7 476552.0 479089.0 480939.0 481599.0 483328.0 49574.3 50307.2 54633.5 56416.4 56624.2 1319.9 1342.5 1344.1 1352.3 1360.2 30721.5 33073.3 33202.8 33244.5 33474.7 50426.2 50755.5 50961.2 51004.5 51005.7 389631.0 393246.0 419972.0 433181.0 436900.0 27129.7 27801.2 27815.0 27943.6 28147.6 46283.3 46512.3 46576.0 46716.3 46805.0 38553.6 39355.8 39828.0 40035.2 41268.8 39376.0 39622.4 40022.4 40385.8 40764.0 39411.8 39597.4 40106.4 40879.4 43803.0 32054.0 35664.0 35886.6 36560.8 36576.0 27194.6 27619.0 27665.4 27921.4 27930.4 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | [#2] jquery.html Cycles:180 Average:26657.87 Median:20226.02 stddev:73313.13 (362.5%) stddev-sans-first:73492.24 06:12:29 INFO - PROCESS | 29418 | Values: 379.7 397.4 403.9 410.8 421.5 13593.6 15655.8 18943.2 19002.3 19111.2 18134.5 18728.6 18836.0 19253.4 19255.2 4607.2 5470.0 5738.5 5743.4 5746.5 5573.2 5626.4 5666.5 5670.4 5671.5 5489.8 5538.8 5679.0 5690.5 5694.3 5584.5 5604.5 5640.2 5641.1 5644.0 4926.6 5015.1 5053.6 5068.7 5071.4 21599.8 22036.8 22402.3 22572.3 22914.8 2378.9 2391.6 2431.7 2599.0 2734.2 13981.8 14143.7 14193.6 14300.1 14322.9 1810.2 1828.4 1832.9 1852.6 1948.0 59626.0 79628.0 79941.6 81233.0 83098.6 10408.6 10486.7 10578.9 10666.0 10889.1 14818.9 14846.2 14920.9 14925.9 14948.1 7156.9 7349.3 7471.4 7624.9 7663.9 6856.3 6875.9 7056.7 7103.7 7118.7 6481.0 6496.6 6530.6 6553.7 6634.6 1788.4 1859.8 1874.1 1918.9 1990.3 726.9 933.7 959.8 995.8 997.2 19474.9 20022.0 20150.6 20252.8 20523.7 966.3 967.9 983.5 997.2 1011.8 10603.0 11327.1 11380.3 11388.1 11441.8 441339.0 441553.0 448112.0 448840.0 451049.0 57806.4 59049.7 76999.0 77538.6 80440.0 998.0 1010.9 1017.3 1035.1 1038.7 16336.5 16648.3 17431.3 17531.1 17968.0 39571.6 39680.8 40054.6 40547.6 41250.0 50913.5 51964.0 52504.7 52686.5 53834.2 7141.9 7906.8 8027.0 8068.6 8388.4 10889.9 12378.3 12387.8 12405.7 12948.9 5574.1 6819.0 9670.0 10800.9 11146.9 10630.9 10696.6 10713.5 10791.6 10934.4 10970.7 11050.7 11155.3 11314.3 11429.7 7433.0 7483.5 7624.1 7829.2 7845.4 10199.9 10868.9 10906.3 10934.6 11116.1 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | [#3] mootools.html Cycles:180 Average:5559.24 Median:5176.03 stddev:3107.18 (60.0%) stddev-sans-first:3100.26 06:12:29 INFO - PROCESS | 29418 | Values: 1410.5 1464.6 1544.6 1668.3 1714.6 7583.2 7748.2 8075.9 8639.8 8642.6 8021.4 8286.1 8311.4 8525.5 8537.3 2207.8 2270.9 2271.2 2272.7 2273.2 1995.8 2035.2 2258.7 2281.7 2339.8 2040.8 2059.3 2059.7 2142.7 2226.5 2193.9 2198.6 2200.9 2201.1 2202.6 2226.3 2243.4 2270.1 2270.1 2270.1 8519.0 8558.4 8562.9 8642.3 8651.9 5038.4 5173.2 5178.8 5181.1 5184.4 3198.3 3299.8 3312.7 3331.1 3332.6 1093.4 1156.4 1178.1 1186.7 1207.2 11358.7 11913.3 11948.8 11959.9 11970.8 4296.5 4416.6 4454.4 4460.9 4475.3 9521.2 9539.1 9558.0 9562.0 9565.1 5145.0 5147.5 5148.3 5151.2 5151.9 4574.6 4682.6 4714.2 4722.8 4772.5 3512.1 3638.3 3669.1 3741.8 3833.8 1140.4 1150.3 1174.5 1178.4 1195.7 830.8 911.3 917.4 946.5 977.2 5832.5 6022.7 6157.3 6173.5 6350.5 905.5 906.9 967.8 986.7 1002.9 3851.9 4034.2 4051.3 4206.5 4234.6 9622.4 9964.5 9981.2 10217.5 10243.3 10183.2 10193.9 10202.6 10204.7 10212.2 7761.8 7931.0 7933.8 7940.2 7943.9 5462.3 5513.4 5708.3 5787.7 5967.2 9725.0 9730.5 9794.1 9846.0 9851.3 8904.4 9204.7 9240.7 9508.0 9873.9 7508.2 7674.4 7677.7 7689.3 7691.0 7911.2 8232.5 8249.0 8260.1 8268.1 7200.4 7226.7 7271.9 7335.8 7456.6 7328.2 7424.1 7478.6 7497.0 7517.5 6593.8 6656.6 6809.8 6811.0 6813.7 4763.4 4780.6 4822.5 4867.8 4982.7 5138.2 5232.4 5264.4 5307.6 5379.7 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | [#4] prototype.html Cycles:180 Average:4705.37 Median:5404.32 stddev:1387.69 (25.7%) stddev-sans-first:1351.95 06:12:29 INFO - PROCESS | 29418 | Values: 317.8 324.2 326.9 329.6 337.9 5333.7 5372.6 5405.0 5418.8 5459.2 5354.4 5355.7 5379.5 5380.8 5429.6 3982.0 4066.6 4094.8 4106.4 4159.5 4146.0 4160.8 4168.5 4177.0 4190.4 4102.2 4129.6 4152.8 4157.8 4168.4 3961.3 3974.5 4050.1 4155.6 4162.5 3677.3 3686.4 3686.9 3700.3 3740.5 5158.7 5184.8 5187.5 5187.8 5226.6 4694.4 4710.2 4756.4 4761.7 4811.4 5511.6 5512.9 5516.3 5517.8 5530.9 4038.8 4049.1 4052.7 4052.9 4056.1 5501.5 5747.3 5762.2 5770.9 5805.4 4148.6 4153.2 4154.6 4156.9 4166.6 4223.3 4248.5 4250.1 4256.2 4257.2 4630.7 4687.2 4742.2 4814.3 4821.0 5571.5 5584.7 5588.3 5593.0 5600.7 1366.7 1373.8 1378.9 1383.7 1385.4 943.5 992.2 995.2 999.0 1011.9 5223.7 5299.7 5310.8 5320.6 5326.9 5597.7 5663.3 5717.3 5761.7 5801.9 5230.5 5337.5 5403.6 5429.5 5442.4 2896.3 2909.7 2933.8 2945.5 2955.9 5740.4 5741.8 5742.9 5749.3 5751.6 5554.3 5656.5 5850.7 5866.2 5873.8 5935.9 5940.2 5940.4 5963.6 5970.3 5608.4 5784.2 5802.5 5809.5 5819.9 5665.7 5672.3 5687.6 5737.8 5746.3 5857.6 5877.8 5882.9 5968.2 6014.8 3842.4 4006.0 4023.0 4030.6 4038.7 5687.9 5695.5 5720.3 5742.1 5752.2 5590.2 5611.9 5612.4 5623.2 5668.1 5389.6 5600.7 5623.6 5638.4 5644.7 5631.7 5637.5 5651.4 5658.5 5708.9 5452.6 5481.9 5578.0 5621.7 5653.4 5531.9 5548.2 5555.1 5560.4 5562.9 06:12:29 INFO - PROCESS | 29418 | 06:12:29 INFO - PROCESS | 29418 | [#5] yui.html Cycles:180 Average:18493.44 Median:4636.05 stddev:24353.85 (525.3%) stddev-sans-first:24385.47 06:12:29 INFO - PROCESS | 29418 | Values: 689.0 700.4 727.3 762.2 776.8 15663.5 16503.8 16776.7 16812.7 16934.7 14940.8 15070.3 15225.7 15235.0 15284.4 663.4 673.2 771.4 781.9 788.3 790.1 803.9 803.9 804.1 804.4 837.0 840.6 841.1 842.5 842.6 697.9 715.8 805.9 826.8 834.0 598.8 600.8 602.4 603.3 603.7 15554.8 15636.2 15681.5 15681.7 15702.5 14606.1 14642.8 14684.3 14801.8 14863.3 11558.7 11739.1 11832.2 12044.8 12140.8 4212.4 4345.8 4372.5 4382.7 4512.8 83929.6 84813.0 85169.0 86473.6 86550.6 11154.8 11252.5 11401.9 11478.4 11519.6 22288.7 22295.7 22305.6 22319.9 22327.2 7828.6 7843.4 7851.7 8086.8 8539.3 4253.6 4444.2 4491.8 4507.9 4529.7 3296.5 3345.3 3348.4 3365.4 3367.1 564.1 564.3 568.4 570.2 574.8 553.7 565.5 620.0 630.8 650.4 8852.9 9179.8 9282.0 9284.5 9410.5 554.8 577.9 634.6 638.3 639.4 4216.0 4589.5 4590.3 4635.6 4636.5 68484.3 69497.0 83408.6 90742.1 93261.5 57838.0 75418.4 77415.0 79723.2 80178.3 70026.0 70925.0 71511.3 71550.6 73911.3 9068.3 9097.5 9127.4 9139.1 9228.8 39821.4 44217.3 47038.8 47627.8 49740.8 55101.7 55105.2 61274.4 61661.7 63496.0 12398.3 12411.2 12420.4 12574.7 12972.6 13993.9 14126.6 14284.4 14401.8 15488.5 13621.8 14149.2 14494.2 14838.3 14869.8 13359.6 13849.4 14154.4 14307.5 14412.2 13034.2 13178.3 13453.2 13496.3 13729.7 11238.8 11544.8 11681.4 11875.5 12036.1 10005.8 11246.7 11405.9 11533.1 11751.5 06:12:29 INFO - PROCESS | 29418 | -------- Summary: end -------- 06:12:29 INFO - PROCESS | 29418 | 06:12:30 INFO - TEST-INFO | 29418: exit 0 06:12:30 INFO - TEST-OK | dromaeo_css | took 1119281ms 06:12:30 INFO - TEST-START | kraken 06:12:30 INFO - operating with platform_type : linux_ 06:12:30 INFO - Initialising browser for kraken test... 06:12:30 INFO - TEST-INFO | started process 29728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsP9X7y/profile http://localhost:34316/getInfo.html) 06:12:34 INFO - PROCESS | 29728 | __metrics Screen width/height:1600/1200 06:12:34 INFO - PROCESS | 29728 | colorDepth:24 06:12:34 INFO - PROCESS | 29728 | Browser inner width/height: 1024/697 06:12:34 INFO - PROCESS | 29728 | __metrics 06:12:35 INFO - PROCESS | 29728 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:12:35 INFO - PROCESS | 29728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:35 INFO - PROCESS | 29728 | console.error: PushService: 06:12:35 INFO - PROCESS | 29728 | stateChangeProcessEnqueue: Error transitioning state 06:12:35 INFO - PROCESS | 29728 | UnknownError 06:12:36 INFO - TEST-INFO | 29728: exit 0 06:12:36 INFO - Browser initialized. 06:12:36 INFO - Running cycle 1/1 for kraken test... 06:12:36 INFO - TEST-INFO | started process 29810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsP9X7y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:48 INFO - PROCESS | 29810 | RSS: Main: 173817856 06:12:48 INFO - PROCESS | 29810 | 06:12:51 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34316/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:52 INFO - PROCESS | 29810 | RSS: Main: 238792704 06:12:52 INFO - PROCESS | 29810 | 06:12:54 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34316/tests/kraken/driver.html?testName=audio-dft) 06:12:55 INFO - PROCESS | 29810 | RSS: Main: 216760320 06:12:55 INFO - PROCESS | 29810 | 06:12:58 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34316/tests/kraken/driver.html?testName=audio-fft) 06:12:59 INFO - PROCESS | 29810 | RSS: Main: 298901504 06:12:59 INFO - PROCESS | 29810 | 06:13:01 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34316/tests/kraken/driver.html?testName=audio-oscillator) 06:13:01 INFO - PROCESS | 29810 | RSS: Main: 209502208 06:13:01 INFO - PROCESS | 29810 | 06:13:03 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:04 INFO - PROCESS | 29810 | RSS: Main: 213852160 06:13:04 INFO - PROCESS | 29810 | 06:13:07 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34316/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:08 INFO - PROCESS | 29810 | RSS: Main: 252870656 06:13:08 INFO - PROCESS | 29810 | 06:13:11 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34316/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:12 INFO - PROCESS | 29810 | RSS: Main: 252125184 06:13:12 INFO - PROCESS | 29810 | 06:13:15 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34316/tests/kraken/driver.html?testName=json-parse-financial) 06:13:15 INFO - PROCESS | 29810 | RSS: Main: 252145664 06:13:15 INFO - PROCESS | 29810 | 06:13:17 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:17 INFO - PROCESS | 29810 | RSS: Main: 214020096 06:13:17 INFO - PROCESS | 29810 | 06:13:19 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:20 INFO - PROCESS | 29810 | RSS: Main: 221437952 06:13:20 INFO - PROCESS | 29810 | 06:13:22 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:22 INFO - PROCESS | 29810 | RSS: Main: 229965824 06:13:22 INFO - PROCESS | 29810 | 06:13:25 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:26 INFO - PROCESS | 29810 | RSS: Main: 239538176 06:13:26 INFO - PROCESS | 29810 | 06:13:29 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:29 INFO - PROCESS | 29810 | RSS: Main: 235692032 06:13:29 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | Cycle 1(1): loaded http://localhost:34316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34316/tests/kraken/driver.html?testName=ai-astar) 06:13:31 INFO - PROCESS | 29810 | RSS: Main: 286875648 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | __start_tp_report 06:13:31 INFO - PROCESS | 29810 | _x_x_mozilla_page_load 06:13:31 INFO - PROCESS | 29810 | _x_x_mozilla_page_load_details 06:13:31 INFO - PROCESS | 29810 | |i|pagename|runs| 06:13:31 INFO - PROCESS | 29810 | |0;ai-astar;110;111;110;110;111;111;111;109;110;110 06:13:31 INFO - PROCESS | 29810 | |1;audio-beat-detection;151;136;127;150;127;129;124;127;152;136 06:13:31 INFO - PROCESS | 29810 | |2;audio-dft;162;161;162;160;161;161;162;162;163;162 06:13:31 INFO - PROCESS | 29810 | |3;audio-fft;75;76;76;112;76;76;76;77;99;75 06:13:31 INFO - PROCESS | 29810 | |4;audio-oscillator;82;83;104;82;82;83;107;83;83;98 06:13:31 INFO - PROCESS | 29810 | |5;imaging-gaussian-blur;126;117;117;117;116;116;117;117;117;116 06:13:31 INFO - PROCESS | 29810 | |6;imaging-darkroom;146;148;148;148;147;149;148;147;147;147 06:13:31 INFO - PROCESS | 29810 | |7;imaging-desaturate;96;96;96;95;97;96;96;95;96;96 06:13:31 INFO - PROCESS | 29810 | |8;json-parse-financial;51;51;52;50;52;54;52;51;51;53 06:13:31 INFO - PROCESS | 29810 | |9;json-stringify-tinderbox;63;63;62;63;64;64;62;62;63;63 06:13:31 INFO - PROCESS | 29810 | |10;stanford-crypto-aes;81;80;84;80;86;80;81;91;81;81 06:13:31 INFO - PROCESS | 29810 | |11;stanford-crypto-ccm;141;130;145;130;132;142;132;131;174;147 06:13:31 INFO - PROCESS | 29810 | |12;stanford-crypto-pbkdf2;168;168;168;172;173;165;164;170;167;168 06:13:31 INFO - PROCESS | 29810 | |13;stanford-crypto-sha256-iterative;65;67;68;66;68;66;65;68;66;65 06:13:31 INFO - PROCESS | 29810 | __end_tp_report 06:13:31 INFO - PROCESS | 29810 | __start_cc_report 06:13:31 INFO - PROCESS | 29810 | _x_x_mozilla_cycle_collect,1689 06:13:31 INFO - PROCESS | 29810 | __end_cc_report 06:13:31 INFO - PROCESS | 29810 | __startTimestamp1480342411629__endTimestamp 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | ------- Summary: start ------- 06:13:31 INFO - PROCESS | 29810 | Number of tests: 14 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:13:31 INFO - PROCESS | 29810 | Values: 110.0 111.0 110.0 110.0 111.0 111.0 111.0 109.0 110.0 110.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:136.00 stddev:11.12 (8.2%) stddev-sans-first:10.37 06:13:31 INFO - PROCESS | 29810 | Values: 151.0 136.0 127.0 150.0 127.0 129.0 124.0 127.0 152.0 136.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 06:13:31 INFO - PROCESS | 29810 | Values: 162.0 161.0 162.0 160.0 161.0 161.0 162.0 162.0 163.0 162.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.87 (16.9%) stddev-sans-first:13.42 06:13:31 INFO - PROCESS | 29810 | Values: 75.0 76.0 76.0 112.0 76.0 76.0 76.0 77.0 99.0 75.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.00 stddev:10.11 (12.2%) stddev-sans-first:10.43 06:13:31 INFO - PROCESS | 29810 | Values: 82.0 83.0 104.0 82.0 82.0 83.0 107.0 83.0 83.0 98.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:2.99 (2.6%) stddev-sans-first:0.50 06:13:31 INFO - PROCESS | 29810 | Values: 126.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 06:13:31 INFO - PROCESS | 29810 | Values: 146.0 148.0 148.0 148.0 147.0 149.0 148.0 147.0 147.0 147.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:13:31 INFO - PROCESS | 29810 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 96.0 95.0 96.0 96.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:1.20 06:13:31 INFO - PROCESS | 29810 | Values: 51.0 51.0 52.0 50.0 52.0 54.0 52.0 51.0 51.0 53.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 06:13:31 INFO - PROCESS | 29810 | Values: 63.0 63.0 62.0 63.0 64.0 64.0 62.0 62.0 63.0 63.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.00 stddev:3.57 (4.4%) stddev-sans-first:3.74 06:13:31 INFO - PROCESS | 29810 | Values: 81.0 80.0 84.0 80.0 86.0 80.0 81.0 91.0 81.0 81.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:141.50 stddev:13.51 (9.5%) stddev-sans-first:14.33 06:13:31 INFO - PROCESS | 29810 | Values: 141.0 130.0 145.0 130.0 132.0 142.0 132.0 131.0 174.0 147.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:2.79 (1.7%) stddev-sans-first:2.96 06:13:31 INFO - PROCESS | 29810 | Values: 168.0 168.0 168.0 172.0 173.0 165.0 164.0 170.0 167.0 168.0 06:13:31 INFO - PROCESS | 29810 | 06:13:31 INFO - PROCESS | 29810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.26 (1.9%) stddev-sans-first:1.24 06:13:31 INFO - PROCESS | 29810 | Values: 65.0 67.0 68.0 66.0 68.0 66.0 65.0 68.0 66.0 65.0 06:13:31 INFO - PROCESS | 29810 | -------- Summary: end -------- 06:13:31 INFO - PROCESS | 29810 | 06:13:32 INFO - TEST-INFO | 29810: exit 0 06:13:32 INFO - TEST-OK | kraken | took 62361ms 06:13:32 INFO - SUITE-END | took 1181s 06:13:33 INFO - Completed test suite (00:19:41) 06:13:33 INFO - javascript benchmark 06:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.39327831073, 3138.827364494953, 3144.3082521845186, 3174.476211425115, 3187.9043628691147, 5274.156135018397, 5331.7334133293325, 5365.087935051041, 5455.809046683366, 5459.372172200198, 5339.145736682131, 5355.812546560871, 5392.110301800208, 5399.244105825188, 5516.007118718629, 4907.312976183337, 4962.801487940496, 4975.477574854643, 4977.0792403405485, 4985.850424487262, 4968.478309777475, 4993.450720420751, 5005.224190250517, 5050.0, 5064.341635587387, 4965.379327584052, 5019.297298378212, 5038.294638750578, 5064.442911279774, 5085.618578606601, 4713.505081966413, 4736.2895565665085, 4738.147133515966, 4837.492063333335, 4954.479779623124, 4795.4964728703335, 4797.0166115946495, 4799.18413869643, 4804.519548045202, 4810.350602668665, 5179.041877252683, 5207.010667973073, 5232.39827419844, 5233.659812112201, 5240.213967904845, 5606.6636001840025, 5615.354234263071, 5615.494605485526, 5618.690971996539, 5618.747156377973, 5654.971725141348, 5665.348484924245, 5671.092625179951, 5671.120976248688, 5673.3475650299915, 5396.892062158774, 5399.70301633414, 5412.242286079952, 5415.891682166334, 5417.295751552273, 5841.561882858802, 5878.882422351529, 5891.499222566044, 5896.262967129109, 5897.439743224387, 5729.627574207663, 5735.0250457422335, 5735.340435849847, 5740.770369185186, 5744.971275143597, 5593.636413633182, 5637.520810731134, 5840.386759390203, 5841.299044114733, 5845.210896528914, 5700.914486282709, 5703.201551782754, 5708.343540492813, 5709.371969083398, 5712.0860662293835, 5720.48515633595, 5720.713964301768, 5727.026405511073, 5727.140928860621, 5731.226284451629, 4426.513083560806, 4445.799939002753, 4456.264716321835, 4473.753943533072, 4518.683692141584, 4011.638952494231, 4035.6569691576547, 4035.6771458283265, 4072.7963601819793, 4076.571959944163, 5247.396549396868, 5519.061759500814, 5519.2824932758485, 5520.0, 5521.668699878021, 5694.886102277931, 5798.82603521895, 5827.125931110282, 5843.883122337529, 5868.853278668067, 5570.248016517799, 5577.553795696334, 5579.9163012554845, 5587.497125258665, 5611.6352437091455, 5046.293518907356, 5057.69653820772, 5103.413107492686, 5108.182690769459, 5154.7164905929785, 5798.217240672455, 5840.883182336414, 5920.644761314335, 5964.671943043, 6021.367756385516, 5882.352941176553, 5886.205362276038, 5888.440598143169, 5920.348761636303, 5940.495057919952, 6048.637081775108, 6050.606710563799, 6054.939450605438, 6057.697115144313, 6064.636121832704, 5563.471470210324, 5574.108142697149, 5597.524210441995, 5759.193712880284, 5771.509421699203, 5732.369439361583, 5761.769529218785, 5820.214271073351, 5849.122631605123, 5862.589618726648, 5606.495415412633, 5631.63394379364, 5638.60529762929, 5640.435956404327, 5641.717914104361, 5466.289382380265, 5476.698781567052, 5660.603757736919, 5664.546836253007, 5668.801591944262, 5642.0, 5646.0, 5659.886802264014, 5686.60193786431, 5782.624129431573, 5736.913946290892, 5769.249997500298, 5778.27771528559, 5780.797672081457, 5782.971085144715, 5445.646033007842, 5648.293963254593, 5658.349289831722, 5661.575381846295, 5663.9716801415725], "value": 5334.31104863196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.3134511285874, 583.8190161050074, 597.5219824140686, 624.4161708802268, 643.7328508668903, 31703.0, 34437.0, 34445.82777086117, 34451.0, 34481.82759086204, 34270.48594271088, 41734.58265417345, 42861.571384286224, 42930.0, 45714.0, 8506.106858779833, 8638.222559969601, 8640.308775297992, 8642.049374568793, 8642.351823613222, 7915.485493442937, 8526.70156544521, 8614.483131012128, 8621.396502244814, 8629.309655227598, 7980.082290536576, 10164.64423745169, 10372.325798823053, 10392.584296628163, 10717.142628589732, 10240.74398140045, 10305.227107966932, 10309.072183503446, 10314.12329951955, 10380.169586433067, 9990.250731195189, 10052.497375131214, 10055.497225138786, 10067.345622534513, 10073.24450666203, 39294.60705392938, 39681.80159099186, 39683.8015809922, 39701.40447893284, 39745.20509589792, 3406.5741782277214, 3534.3024967686347, 3563.6436356364156, 3838.6161383861668, 3920.0003998980364, 30754.692453075408, 31196.376072478422, 31634.0, 31656.36687266265, 31692.524612130837, 4117.402976568381, 4182.1008483176265, 4256.659467242614, 4295.763732994684, 4397.582229688206, 325375.9999999976, 326876.0, 327635.0, 328083.0, 329447.0, 58359.0, 58762.41237587655, 58766.0, 58780.70609646924, 58807.411925881046, 60110.0, 60530.0, 60679.0, 60694.69652651797, 60695.393046069854, 14790.704185916222, 15188.46840360582, 15190.696186076217, 15199.164045977577, 15211.315490802941, 11679.182457227913, 11751.0, 11751.294922304689, 11755.529778808752, 11760.470778814974, 15950.840491595167, 16211.0, 17710.822891771175, 18165.182566784526, 18235.54411139732, 5752.36723960364, 6038.607490513103, 6048.727807248684, 6075.939240607626, 6085.0, 940.3652534539159, 987.5555999800118, 1033.7415646088477, 1038.314712289885, 1128.7347473343757, 31656.841715791274, 31769.20576985594, 31831.0, 32074.83962580219, 32334.676653233637, 1025.5180065369264, 1096.873859506167, 1137.9829302560302, 1150.5847807197026, 1194.7670204310075, 15906.0, 16472.505824825275, 16676.33294668224, 16754.497365079067, 16765.7485137723, 476552.0, 479089.0, 480939.0, 481599.0, 483328.0, 49574.25638615424, 50307.24539131916, 54633.45366546363, 56416.43583564194, 56624.150637740466, 1319.920804751718, 1342.5166939901824, 1344.1128854955878, 1352.2697743218946, 1360.2314692199075, 30721.53917691281, 33073.33853322968, 33202.833985829915, 33244.50133247955, 33474.66525334716, 50426.2436063452, 50755.492445076554, 50961.23558146705, 51004.489955099976, 51005.74497127491, 389631.0, 393246.0, 419972.0, 433181.0, 436900.0, 27129.72870271272, 27801.165965021082, 27815.0, 27943.58084628773, 28147.57778633363, 46283.3057504131, 46512.25572291931, 46576.0, 46716.299255510516, 46805.0, 38553.61446385612, 39355.80322098371, 39828.0, 40035.1992960145, 41268.79365603153, 39376.0, 39622.40566391564, 40022.39966400564, 40385.798071009456, 40764.0, 39411.802940985115, 39597.40603890886, 40106.39840402455, 40879.386809198484, 43803.0, 32054.0, 35664.0, 35886.59077387644, 36560.81719591385, 36576.0, 27194.592081118404, 27619.0, 27665.446691066467, 27921.44157116887, 27930.441391171655], "value": 19563.48015453253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.72469959279545, 397.439610149689, 403.8828739665497, 410.82950575511154, 421.466844441781, 13593.592192234237, 15655.765163522556, 18943.242270309172, 19002.334918277862, 19111.235550577996, 18134.455966321, 18728.625427491443, 18836.0, 19253.422397328104, 19255.229790808386, 4607.239805432099, 5470.0, 5738.512226460735, 5743.368229494752, 5746.48281654651, 5573.219749235111, 5626.409227031164, 5666.46168613981, 5670.404607516213, 5671.489565939065, 5489.835304940858, 5538.778448862041, 5679.0, 5690.459406356389, 5694.316681998166, 5584.52531534818, 5604.495595396414, 5640.182173584807, 5641.069223578104, 5643.999999999979, 4926.630502712275, 5015.14742493777, 5053.620978426633, 5068.670536415121, 5071.442141364447, 21599.784002159933, 22036.779632203634, 22402.327930162122, 22572.322830315115, 22914.770852291596, 2378.9167379141645, 2391.557561851063, 2431.6838810954464, 2599.038355808344, 2734.1934129431866, 13981.79027314591, 14143.717125657533, 14193.574192774233, 14300.141991480545, 14322.856771432256, 1810.1582764014797, 1828.4240464253717, 1832.8533717302716, 1852.555386707194, 1948.0357223174478, 59626.0, 79628.0, 79941.60029199875, 81233.0, 83098.58450707768, 10408.583656653649, 10486.73783155412, 10578.889216632297, 10666.0, 10889.074428673652, 14818.851811481964, 14846.18345990981, 14920.925395373171, 14925.850741492663, 14948.103113813206, 7156.856862862714, 7349.280766116464, 7471.364933980563, 7624.923750762532, 7663.8850417242675, 6856.348646878539, 6875.862482750417, 7056.717731290691, 7103.715851365991, 7118.679659415338, 6480.967595162088, 6496.577722448026, 6530.640814755139, 6553.672316384162, 6634.601923884582, 1788.4098247578268, 1859.7768267807949, 1874.137896567567, 1918.894460804669, 1990.2735501541833, 726.8987483961802, 933.7432206143365, 959.8176346494143, 995.7958618483193, 997.2221667099674, 19474.902625486782, 20022.0, 20150.596988060155, 20252.797472025384, 20523.692144617842, 966.2752935298527, 967.9370840895319, 983.4640121133999, 997.1972562087444, 1011.838105903052, 10603.0, 11327.093832493381, 11380.260283081574, 11388.088952883749, 11441.771164576829, 441339.0, 441553.0, 448112.0, 448840.0, 451049.0, 57806.42193578094, 59049.70475147597, 76999.0, 77538.6123069381, 80440.0, 998.0219385002738, 1010.9443980581138, 1017.343813240441, 1035.0580971316067, 1038.6520515627199, 16336.509904702878, 16648.3340666372, 17431.302747889942, 17531.123443827502, 17968.0, 39571.60428395679, 39680.80159599299, 40054.59945400509, 40547.59452405438, 41250.0, 50913.49086509088, 51964.0, 52504.73747631237, 52686.473135268156, 53834.192487113505, 7141.85716285661, 7906.7627971160955, 8026.989878795452, 8068.556229407439, 8388.412811103164, 10889.891101088888, 12378.319192444142, 12387.814182787446, 12405.689857753629, 12948.93525532404, 5574.052411090205, 6819.0, 9670.0, 10800.945995269973, 11146.88853111491, 10630.946845265724, 10696.62561810333, 10713.464326783786, 10791.56833726642, 10934.398608076313, 10970.725731856448, 11050.723731906444, 11155.330680159217, 11314.321140731583, 11429.657110286706, 7432.962835185789, 7483.476156668981, 7624.123225829101, 7829.177936316605, 7845.3723702104835, 10199.898001019896, 10868.891311086787, 10906.34561926287, 10934.562617495529, 11116.110711142928], "value": 8896.010486253592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.4851729118868, 1464.641162915086, 1544.5675210940933, 1668.2576253567167, 1714.5884987602979, 7583.165851756303, 7748.225177482249, 8075.9192408075905, 8639.784005399868, 8642.611082501287, 8021.438499305051, 8286.129956354587, 8311.376646751487, 8525.531095789729, 8537.2743316818, 2207.8233741300655, 2270.909163633453, 2271.1823743452346, 2272.6704627828954, 2273.227102785061, 1995.8103980121866, 2035.1655821113347, 2258.6837842702034, 2281.7490076091617, 2339.8128149748063, 2040.7653119891254, 2059.3307175168056, 2059.70134330522, 2142.700021996922, 2226.510167763098, 2193.8793366364844, 2198.5712786006734, 2200.9119635214574, 2201.0975500045065, 2202.581509513195, 2226.25420484138, 2243.4279258788906, 2270.0692715986365, 2270.0919632147106, 2270.14869423966, 8519.0, 8558.358123140728, 8562.871556926651, 8642.30861531076, 8651.870221946676, 5038.39539255288, 5173.249878767558, 5178.818741344035, 5181.145111056671, 5184.377874655028, 3198.328351046283, 3299.8185099819502, 3312.668733126692, 3331.1006028372203, 3332.6334103248623, 1093.3877028863783, 1156.404451707363, 1178.0752109594014, 1186.6914602203403, 1207.233406786688, 11358.71603209918, 11913.285202887855, 11948.820767688492, 11959.94020029903, 11970.760584788342, 4296.505901821268, 4416.558344165558, 4454.37638730578, 4460.929376949509, 4475.30632751924, 9521.190698790542, 9539.09378609031, 9558.0, 9562.0, 9565.091316324939, 5145.0, 5147.510986456281, 5148.253503242009, 5151.2273159026445, 5151.948480515147, 4574.588287054181, 4682.618627504894, 4714.198586240347, 4722.763861806896, 4772.451168115642, 3512.104413374573, 3638.2723455308515, 3669.1010702377553, 3741.7567858089137, 3833.846646134179, 1140.3955903371227, 1150.3155622404656, 1174.5301879248198, 1178.4225729392535, 1195.7429152732204, 830.7839961609905, 911.3256190419042, 917.3761841947539, 946.5030858799048, 977.1596427072711, 5832.504237139806, 6022.728977196037, 6157.291911430243, 6173.536984726164, 6350.4602108820345, 905.5239958867005, 906.9365144439826, 967.7822489939848, 986.72712201261, 1002.9448380339152, 3851.9229615407535, 4034.152827906114, 4051.2707712612014, 4206.47419072616, 4234.55537168599, 9622.422654640604, 9964.451955142391, 9981.201503879673, 10217.540210690388, 10243.334183278062, 10183.18534517237, 10193.949030254802, 10202.591896324064, 10204.744881378025, 10212.234082443847, 7761.7671469855995, 7930.9603451982375, 7933.841323173504, 7940.245676660708, 7943.920560794434, 5462.317210348707, 5513.421090785409, 5708.257926469532, 5787.726700125965, 5967.164596956516, 9724.95137524308, 9730.513474326397, 9794.118529332109, 9845.950770246103, 9851.261155413229, 8904.421212621159, 9204.677836275698, 9240.676576319796, 9508.049195080437, 9873.851892221479, 7508.211637777955, 7674.386049116169, 7677.731279405418, 7689.269519395649, 7691.0, 7911.1693272207895, 8232.50604963704, 8249.0, 8260.091389947222, 8268.09051004401, 7200.351968322876, 7226.74706385274, 7271.8909216360735, 7335.77992660221, 7456.627168641655, 7328.157261914948, 7424.1462231844025, 7478.551286922802, 7496.987906632535, 7517.511361761687, 6593.80218593443, 6656.635389745187, 6809.795706128824, 6811.0, 6813.693383797642, 4763.3807605011125, 4780.617550596014, 4822.541858523435, 4867.780949857194, 4982.7259500727805, 5138.203578445347, 5232.442732938994, 5264.447233040476, 5307.57539396855, 5379.704116273486], "value": 4469.654913074046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.7870826546214, 324.2461277529744, 326.92644155065113, 329.55510061417084, 337.85978818790204, 5333.706646134461, 5372.623916325849, 5405.027165084745, 5418.837434876955, 5459.153831156167, 5354.41101478838, 5355.651882627626, 5379.542738867201, 5380.784768609251, 5429.56563474922, 3981.9800900995456, 4066.573009833969, 4094.815733292009, 4106.3924408000985, 4159.500859896817, 4145.979270103645, 4160.750354978696, 4168.499780026386, 4176.958230417703, 4190.434291370671, 4102.159057393227, 4129.587041295877, 4152.792360381984, 4157.833686652531, 4168.353905144708, 3961.2869683456966, 3974.503187101612, 4050.129222217223, 4155.625993660555, 4162.521310049353, 3677.3380791457525, 3686.3733165361955, 3686.9262614747554, 3700.296943580738, 3740.4950331705145, 5158.664686795384, 5184.844454666366, 5187.48125187482, 5187.818426355059, 5226.5818734501145, 4694.427366832116, 4710.24636058229, 4756.381670382828, 4761.714297142183, 4811.398575178103, 5511.614187006911, 5512.862178445531, 5516.338039435253, 5517.813670060957, 5530.889382212374, 4038.7576745395077, 4049.1496785675045, 4052.7163098582814, 4052.9189416211807, 4056.1482088761395, 5501.504864562168, 5747.252857128588, 5762.193292938992, 5770.884582308372, 5805.4194580542035, 4148.56440073794, 4153.190127925086, 4154.584541545822, 4156.896077598024, 4166.604172603597, 4223.260929337353, 4248.468941382327, 4250.107477429712, 4256.191323648497, 4257.23369793434, 4630.72215667061, 4687.156311863897, 4742.241241401359, 4814.301926220678, 4820.9517904821205, 5571.470710282517, 5584.664920104807, 5588.329400471969, 5592.972035139798, 5600.663960162403, 1366.7403193393222, 1373.8488766235705, 1378.945106993151, 1383.7338834965894, 1385.4181243877595, 943.5188054092463, 992.151710287708, 995.2237254941158, 998.9500524973722, 1011.8785745710414, 5223.738813059332, 5299.735013249322, 5310.7610157543, 5320.574354051667, 5326.866828329323, 5597.6641401516035, 5663.292088488939, 5717.341970828496, 5761.711914404263, 5801.854953626109, 5230.476952304815, 5337.466253374709, 5403.621746477709, 5429.484199001088, 5442.374126975369, 2896.2614533293877, 2909.6577255309257, 2933.823970561773, 2945.528715405525, 2955.852207389622, 5740.44550175168, 5741.827745167651, 5742.942570574241, 5749.310082790092, 5751.568632352591, 5554.333479982347, 5656.462636049569, 5850.678212698343, 5866.178734977107, 5873.765049397976, 5935.851603709855, 5940.168376427304, 5940.376260492672, 5963.5825492216, 5970.253718285215, 5608.439156084359, 5784.161296611884, 5802.533923082758, 5809.50619197373, 5819.912701309569, 5665.66006039639, 5672.290963629546, 5687.606536398609, 5737.799177028784, 5746.2529871116485, 5857.648541087548, 5877.764889404376, 5882.882342353215, 5968.165121567221, 6014.789482368096, 3842.442845787289, 4006.0, 4022.9597704022585, 4030.6372426481757, 4038.6970977176243, 5687.914681279867, 5695.544356451391, 5720.342160651412, 5742.052561327334, 5752.1659359391815, 5590.217369568182, 5611.943880561143, 5612.438756124355, 5623.1846382273525, 5668.149777533403, 5389.59578031657, 5600.7199640017025, 5623.550115990629, 5638.351589567253, 5644.745986430538, 5631.746571404378, 5637.5489960802215, 5651.4348565143155, 5658.519025882846, 5708.885822283614, 5452.645578037414, 5481.862953426196, 5578.0, 5621.662700237999, 5653.3781284057895, 5531.917021244604, 5548.195511650869, 5555.111182210827, 5560.36055853582, 5562.860928476821], "value": 4261.017528548087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.9689963951622, 700.4081551089331, 727.2836256287558, 762.1578156137472, 776.7592046465596, 15663.451779187732, 16503.752443713325, 16776.748348774778, 16812.66374672506, 16934.745978810326, 14940.775888361683, 15070.321835517401, 15225.695486090272, 15235.0, 15284.388624455009, 663.3996233408749, 673.1753601837759, 771.3944553525483, 781.9296263336298, 788.2590365056857, 790.0558832195528, 803.8593246181924, 803.9316658084069, 804.1194891593725, 804.3565147881701, 836.958152092396, 840.5965136734371, 841.1210285251896, 842.4608250719544, 842.5744998775609, 697.9162500499973, 715.8317795318096, 805.879118132279, 826.7519744076783, 833.9583020848963, 598.8083813179784, 600.7957294519884, 602.3945934336008, 603.291132918823, 603.6951339573532, 15554.844451555453, 15636.2181890905, 15681.451149209837, 15681.686366272725, 15702.528924132293, 14606.12363258208, 14642.780358294527, 14684.339204735812, 14801.779733040023, 14863.33115009827, 11558.711032224262, 11739.128261771355, 11832.171747977645, 12044.759104817942, 12140.757184856342, 4212.368144778277, 4345.847895323648, 4372.475302963633, 4382.671299652507, 4512.819487220508, 83929.58035209785, 84813.0, 85169.0, 86473.56763216143, 86550.56724716398, 11154.832677509843, 11252.493637786156, 11401.885981140082, 11478.439835351497, 11519.596814111634, 22288.66567001496, 22295.665565016538, 22305.55388892213, 22319.88840055822, 22327.21854735109, 7828.608569571498, 7843.411744119214, 7851.685932562747, 8086.757397277974, 8539.274161696325, 4253.63844073251, 4444.177827101997, 4491.8203271869415, 4507.925448528184, 4529.660275479287, 3296.5055241713453, 3345.34765720687, 3348.447506161456, 3365.4110530657035, 3367.124547617637, 564.0692856786253, 564.297449675157, 568.3804652928245, 570.2444261353722, 574.7930744931821, 553.6622660177288, 565.527784300114, 620.0265583034592, 630.817217716781, 650.3593959949446, 8852.8672069919, 9179.77050573741, 9281.964959810308, 9284.535773211312, 9410.529473526296, 554.7669978608994, 577.9364269930304, 634.6097150252654, 638.3074364314771, 639.4468784501373, 4216.0, 4589.54104589545, 4590.334401511762, 4635.605973492224, 4636.4899861015265, 68484.3151568488, 69497.0, 83408.58295708483, 90742.09257907336, 93261.5336923311, 57838.0, 75418.36035738722, 77415.0, 79723.20276797158, 80178.32204324754, 70026.0, 70925.0, 71511.28488715047, 71550.64224678843, 73911.26088739152, 9068.319876009195, 9097.454152750855, 9127.406718563272, 9139.131782480654, 9228.815423691623, 39821.40267896042, 44217.33673994957, 47038.76480617575, 47627.76186119047, 49740.75129624329, 55101.72449137729, 55105.17342239789, 61274.387256126865, 61661.69169154126, 63496.0, 12398.318092504998, 12411.193272437262, 12420.378981051092, 12574.685632859251, 12972.610821675366, 13993.860061399255, 14126.576202713935, 14284.35720392564, 14401.78397324062, 15488.5353439397, 13621.79567306511, 14149.221792801494, 14494.202818845064, 14838.332275047433, 14869.776953345925, 13359.599212023655, 13849.376558603492, 14154.433822646979, 14307.499237526637, 14412.207328597027, 13034.152780069644, 13178.275194864374, 13453.160943916948, 13496.325183740577, 13729.656758580715, 11238.831417528907, 11544.769104618028, 11681.357525336189, 11875.465604047666, 12036.097292703258, 10005.791775678408, 11246.66260012201, 11405.885941140814, 11533.135014873751, 11751.529938802352], "value": 7214.339571873312, "unit": "score"}], "name": "dromaeo_css", "value": 7095.0916981392775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 109.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 136.0, 127.0, 150.0, 127.0, 129.0, 124.0, 127.0, 152.0, 136.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 162.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 76.0, 76.0, 76.0, 77.0, 99.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 104.0, 82.0, 82.0, 83.0, 107.0, 83.0, 83.0, 98.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 50.0, 52.0, 54.0, 52.0, 51.0, 51.0, 53.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 64.0, 62.0, 62.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 84.0, 80.0, 86.0, 80.0, 81.0, 91.0, 81.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 130.0, 145.0, 130.0, 132.0, 142.0, 132.0, 131.0, 174.0, 147.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 172.0, 173.0, 165.0, 164.0, 170.0, 167.0, 168.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 66.0, 68.0, 66.0, 65.0, 68.0, 66.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1511.5000000000002, "alertThreshold": 2.0}]} 06:13:33 INFO - Return code: 0 06:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:33 INFO - # TBPL SUCCESS # 06:13:33 INFO - Running post-action listener: _resource_record_post_action 06:13:33 INFO - [mozharness: 2016-11-28 14:13:33.448645Z] Finished run-tests step (success) 06:13:33 INFO - Running post-run listener: _resource_record_post_run 06:13:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393039872; Read time: 164; Write time: 253364 06:13:33 INFO - TinderboxPrint: CPU usage
13.1% 06:13:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 164 06:13:33 INFO - TinderboxPrint: I/O write bytes / time
393,039,872 / 253,364 06:13:33 INFO - TinderboxPrint: CPU idle
8,313.4 (86.9%) 06:13:33 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 06:13:33 INFO - TinderboxPrint: Swap in / out
0 / 0 06:13:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103911424; Read time: 0; Write time: 68800 06:13:33 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289128448; Read time: 152; Write time: 184564 06:13:34 INFO - Running post-run listener: _upload_blobber_files 06:13:34 INFO - Blob upload gear active. 06:13:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:34 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 06:13:34 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:13:34 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:13:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:35 INFO - (blobuploader) - INFO - Done attempting. 06:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:38 INFO - (blobuploader) - INFO - Done attempting. 06:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:39 INFO - (blobuploader) - INFO - Done attempting. 06:13:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:39 INFO - Return code: 0 06:13:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd58d452ce6fff5d10254f661f584ee4264482c152cad1d8dd002c58e53654e7cfdc9499a80b1adda87dba9e41636d40404367b60c9aef4b341f7ed1a82743c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1664bb307820222978b37d5f0293a80ff649c7e541e8d152646b6f72914aefa8a9ad910234c408dce48ebe09a51439fd2d04e8b18852552aa089e9835133e9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b570ee79a060f86b56097f6dabd55ebbd989dc580c1d4b7fc93fa48e879f3843b3f7ffc8639233af6fa67499c93bb2d385a369ba9dd9603806b6d7ecf3e520b6"} 06:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:39 INFO - Contents: 06:13:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd58d452ce6fff5d10254f661f584ee4264482c152cad1d8dd002c58e53654e7cfdc9499a80b1adda87dba9e41636d40404367b60c9aef4b341f7ed1a82743c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1664bb307820222978b37d5f0293a80ff649c7e541e8d152646b6f72914aefa8a9ad910234c408dce48ebe09a51439fd2d04e8b18852552aa089e9835133e9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b570ee79a060f86b56097f6dabd55ebbd989dc580c1d4b7fc93fa48e879f3843b3f7ffc8639233af6fa67499c93bb2d385a369ba9dd9603806b6d7ecf3e520b6"} 06:13:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:39 INFO - Copying logs to upload dir... 06:13:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.726300 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-28 06:13:39.226724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 06:13:39.230508) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483 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/sha512/cd58d452ce6fff5d10254f661f584ee4264482c152cad1d8dd002c58e53654e7cfdc9499a80b1adda87dba9e41636d40404367b60c9aef4b341f7ed1a82743c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1664bb307820222978b37d5f0293a80ff649c7e541e8d152646b6f72914aefa8a9ad910234c408dce48ebe09a51439fd2d04e8b18852552aa089e9835133e9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b570ee79a060f86b56097f6dabd55ebbd989dc580c1d4b7fc93fa48e879f3843b3f7ffc8639233af6fa67499c93bb2d385a369ba9dd9603806b6d7ecf3e520b6"} build_url:https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/WVVPDi7gRR-ifjg87uPAUQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd58d452ce6fff5d10254f661f584ee4264482c152cad1d8dd002c58e53654e7cfdc9499a80b1adda87dba9e41636d40404367b60c9aef4b341f7ed1a82743c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1664bb307820222978b37d5f0293a80ff649c7e541e8d152646b6f72914aefa8a9ad910234c408dce48ebe09a51439fd2d04e8b18852552aa089e9835133e9f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b570ee79a060f86b56097f6dabd55ebbd989dc580c1d4b7fc93fa48e879f3843b3f7ffc8639233af6fa67499c93bb2d385a369ba9dd9603806b6d7ecf3e520b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 06:13:39.258727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 06:13:39.259433) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480340671.303493-738600483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 06:13:39.347977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 06:13:39.348480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 06:13:39.349025) ========= ========= Total master_lag: 0.24 =========