builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1483953697.84 results: success (0) buildid: 20170108234108 builduid: 61c8c2b722174db491f223ed4bcb537d revision: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:37.842409) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:37.842851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:37.843151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:37.857943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:37.858420) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 01:21:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-01-09 01:21:38 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142688 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.015526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.015850) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020716 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.066754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.067064) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 --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=2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 01:21:38,882 truncating revision to first 12 chars 2017-01-09 01:21:38,882 Setting DEBUG logging. 2017-01-09 01:21:38,882 attempt 1/10 2017-01-09 01:21:38,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fed81ec38bdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 01:21:39,215 unpacking tar archive at: mozilla-aurora-fed81ec38bdf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.807421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.807690) ========= script_repo_revision: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.808060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.808321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 01:21:38.819446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-09 01:21:38.819705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:21:39 INFO - MultiFileLogger online at 20170109 01:21:39 in /builds/slave/test 01:21:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:21:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:21:39 INFO - {'append_to_log': False, 01:21:39 INFO - 'base_work_dir': '/builds/slave/test', 01:21:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:21:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:21:39 INFO - 'branch': 'Mozilla-Aurora', 01:21:39 INFO - 'buildbot_json_path': 'buildprops.json', 01:21:39 INFO - 'config_files': ('talos/linux_config.py',), 01:21:39 INFO - 'default_actions': ('clobber', 01:21:39 INFO - 'read-buildbot-config', 01:21:39 INFO - 'download-and-extract', 01:21:39 INFO - 'populate-webroot', 01:21:39 INFO - 'create-virtualenv', 01:21:39 INFO - 'install', 01:21:39 INFO - 'run-tests'), 01:21:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:21:39 INFO - 'download_minidump_stackwalk': True, 01:21:39 INFO - 'download_symbols': 'ondemand', 01:21:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:21:39 INFO - 'tooltool.py': '/tools/tooltool.py', 01:21:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:21:39 INFO - '/tools/misc-python/virtualenv.py')}, 01:21:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:21:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:21:39 INFO - 'installer_path': 'installer.exe', 01:21:39 INFO - 'log_level': 'info', 01:21:39 INFO - 'log_name': 'talos', 01:21:39 INFO - 'log_to_console': True, 01:21:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:21:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:21:39 INFO - 'opt_config_files': (), 01:21:39 INFO - 'pip_index': False, 01:21:39 INFO - 'sps_profile': False, 01:21:39 INFO - 'sps_profile_interval': 0, 01:21:39 INFO - 'suite': 'dromaeojs', 01:21:39 INFO - 'system_bits': '32', 01:21:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:21:39 INFO - 'title': 'talos-linux64-ix-012', 01:21:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:21:39 INFO - 'use_talos_json': True, 01:21:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:21:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:21:39 INFO - 'work_dir': 'build'} 01:21:39 INFO - [mozharness: 2017-01-09 09:21:39.727398Z] Running clobber step. 01:21:39 INFO - Running pre-action listener: _resource_record_pre_action 01:21:39 INFO - Running main action method: clobber 01:21:39 INFO - rmtree: /builds/slave/test/build 01:21:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:21:40 INFO - Running post-action listener: _resource_record_post_action 01:21:40 INFO - [mozharness: 2017-01-09 09:21:40.183282Z] Finished clobber step (success) 01:21:40 INFO - [mozharness: 2017-01-09 09:21:40.183382Z] Running read-buildbot-config step. 01:21:40 INFO - Running pre-action listener: _resource_record_pre_action 01:21:40 INFO - Running main action method: read_buildbot_config 01:21:40 INFO - Using buildbot properties: 01:21:40 INFO - { 01:21:40 INFO - "project": "", 01:21:40 INFO - "product": "firefox", 01:21:40 INFO - "script_repo_revision": "production", 01:21:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:21:40 INFO - "repository": "", 01:21:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:21:40 INFO - "buildid": "20170108234108", 01:21:40 INFO - "pgo_build": "True", 01:21:40 INFO - "basedir": "/builds/slave/test", 01:21:40 INFO - "buildnumber": 719, 01:21:40 INFO - "slavename": "talos-linux64-ix-012", 01:21:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:21:40 INFO - "platform": "ubuntu64_hw", 01:21:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:21:40 INFO - "branch": "mozilla-aurora", 01:21:40 INFO - "repo_path": "releases/mozilla-aurora", 01:21:40 INFO - "revision": "fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86", 01:21:40 INFO - "stage_platform": "linux64-pgo", 01:21:40 INFO - "builduid": "61c8c2b722174db491f223ed4bcb537d", 01:21:40 INFO - "slavebuilddir": "test" 01:21:40 INFO - } 01:21:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 01:21:40 INFO - Running post-action listener: _resource_record_post_action 01:21:40 INFO - [mozharness: 2017-01-09 09:21:40.185781Z] Finished read-buildbot-config step (success) 01:21:40 INFO - [mozharness: 2017-01-09 09:21:40.185869Z] Running download-and-extract step. 01:21:40 INFO - Running pre-action listener: _resource_record_pre_action 01:21:40 INFO - Running main action method: download_and_extract 01:21:40 INFO - mkdir: /builds/slave/test/build/tests 01:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:40 INFO - trying https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:21:40 INFO - Downloaded 1361 bytes. 01:21:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 01:21:40 INFO - Using the following test package requirements: 01:21:40 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 01:21:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:21:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:21:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'jsshell-linux-x86_64.zip'], 01:21:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:21:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 01:21:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:21:40 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:21:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:21:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 01:21:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:21:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:21:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 01:21:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:21:40 INFO - Fetch https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 01:21:41 INFO - Http code: 200 01:21:41 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 01:21:41 INFO - x-amz-cf-id: NpenTeTewMnZFaAE-ZS5ZCmXTTgjLzQ8J2s0Re7Pd_x9vijJQ2jwhw== 01:21:41 INFO - x-amz-version-id: dhNtLWrlBZYeT9EXBtfj6SC6AbA9OA83 01:21:41 INFO - Expected file size: 21943635 01:21:41 INFO - Obtained file size: 21943635 01:21:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:21:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 01:21:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:21:45 INFO - Fetch https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 01:21:46 INFO - Http code: 200 01:21:46 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 01:21:46 INFO - x-amz-cf-id: 05KEUfJJoTQCkb0AWwFEBykXreRbFeXn7MjuwejdepSK3fh7zJSLTw== 01:21:46 INFO - x-amz-version-id: dhNtLWrlBZYeT9EXBtfj6SC6AbA9OA83 01:21:46 INFO - Expected file size: 21943635 01:21:46 INFO - Obtained file size: 21943635 01:21:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 01:21:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:21:50 INFO - Fetch https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 01:21:51 INFO - Http code: 200 01:21:51 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 01:21:51 INFO - x-amz-cf-id: G7BttIAJmETT4J1ywJ9GdZdhhE1KD-cNVuQsSNK3w8KDCMSGw2pgHg== 01:21:51 INFO - x-amz-version-id: 7QCeq7OiOGPItt9t84_eCj5KbA8zKzVv 01:21:52 INFO - Expected file size: 14409038 01:21:52 INFO - Obtained file size: 14409038 01:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:52 INFO - trying https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:21:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:21:54 INFO - Downloaded 64087850 bytes. 01:21:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:21:54 INFO - mkdir: /builds/slave/test/properties 01:21:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:21:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:21:54 INFO - Contents: 01:21:54 INFO - build_url:https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 01:21:54 INFO - Running post-action listener: _resource_record_post_action 01:21:54 INFO - Running post-action listener: set_extra_try_arguments 01:21:54 INFO - [mozharness: 2017-01-09 09:21:54.942841Z] Finished download-and-extract step (success) 01:21:54 INFO - [mozharness: 2017-01-09 09:21:54.943104Z] Running populate-webroot step. 01:21:54 INFO - Running pre-action listener: _resource_record_pre_action 01:21:54 INFO - Running main action method: populate_webroot 01:21:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:21:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:21:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:21:54 INFO - '--tppagecycles', 01:21:54 INFO - '7'], 01:21:54 INFO - 'tests': ['tsvgm']}}, 01:21:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:21:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:21:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:21:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:21:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:21:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['damp', 'tps']}, 01:21:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'tests': ['damp', 'tps']}, 01:21:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['dromaeo_dom']}, 01:21:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:21:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['basic_compositor_video']}, 01:21:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:21:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['a11yr', 01:21:54 INFO - 'ts_paint', 01:21:54 INFO - 'tpaint', 01:21:54 INFO - 'sessionrestore', 01:21:54 INFO - 'sessionrestore_no_auto_restore', 01:21:54 INFO - 'tabpaint']}, 01:21:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:21:54 INFO - 'ts_paint', 01:21:54 INFO - 'tpaint', 01:21:54 INFO - 'sessionrestore', 01:21:54 INFO - 'sessionrestore_no_auto_restore', 01:21:54 INFO - 'tabpaint']}, 01:21:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:21:54 INFO - 'ts_paint', 01:21:54 INFO - 'tpaint', 01:21:54 INFO - 'sessionrestore', 01:21:54 INFO - 'sessionrestore_no_auto_restore', 01:21:54 INFO - 'tabpaint']}, 01:21:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:21:54 INFO - 'ts_paint', 01:21:54 INFO - 'tpaint', 01:21:54 INFO - 'sessionrestore', 01:21:54 INFO - 'sessionrestore_no_auto_restore', 01:21:54 INFO - 'tabpaint']}, 01:21:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['a11yr', 01:21:54 INFO - 'ts_paint', 01:21:54 INFO - 'tpaint', 01:21:54 INFO - 'sessionrestore', 01:21:54 INFO - 'sessionrestore_no_auto_restore', 01:21:54 INFO - 'tabpaint']}, 01:21:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['a11yr', 01:21:54 INFO - 'ts_paint', 01:21:54 INFO - 'tpaint', 01:21:54 INFO - 'sessionrestore', 01:21:54 INFO - 'sessionrestore_no_auto_restore', 01:21:54 INFO - 'tabpaint']}, 01:21:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['tsvgx', 01:21:54 INFO - 'tsvgr_opacity', 01:21:54 INFO - 'tart', 01:21:54 INFO - 'tscrollx', 01:21:54 INFO - 'cart']}, 01:21:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:21:54 INFO - 'tsvgr_opacity', 01:21:54 INFO - 'tart', 01:21:54 INFO - 'tscrollx', 01:21:54 INFO - 'cart']}, 01:21:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'talos_options': ['--disable-e10s'], 01:21:54 INFO - 'tests': ['tp5o']}, 01:21:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'tests': ['tp5o']}, 01:21:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'talos_options': ['--disable-e10s', 01:21:54 INFO - '--xperf_path', 01:21:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:54 INFO - 'tests': ['tp5n']}, 01:21:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:21:54 INFO - 'talos_options': ['--xperf_path', 01:21:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:21:54 INFO - 'tests': ['tp5n']}}, 01:21:54 INFO - 'talos.zip': {'path': '', 01:21:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:21:54 INFO - Running post-action listener: _resource_record_post_action 01:21:54 INFO - [mozharness: 2017-01-09 09:21:54.961328Z] Finished populate-webroot step (success) 01:21:54 INFO - [mozharness: 2017-01-09 09:21:54.961416Z] Running create-virtualenv step. 01:21:54 INFO - Running pre-action listener: _resource_record_pre_action 01:21:54 INFO - Running main action method: create_virtualenv 01:21:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:21:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:21:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:21:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:21:55 INFO - Using real prefix '/usr' 01:21:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:21:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:21:57 INFO - Installing pip.................done. 01:21:57 INFO - Return code: 0 01:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:21:57 INFO - Reading from file tmpfile_stdout 01:21:57 INFO - Output received: 01:21:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:21:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:21:57 INFO - Using env: {'DISPLAY': ':0', 01:21:57 INFO - 'HOME': '/home/cltbld', 01:21:57 INFO - 'LANG': 'en_US.UTF-8', 01:21:57 INFO - 'LANGUAGE': 'en_US:en', 01:21:57 INFO - 'LOGNAME': 'cltbld', 01:21:57 INFO - 'MAIL': '/var/mail/cltbld', 01:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:57 INFO - 'MOZ_NO_REMOTE': '1', 01:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:57 INFO - 'NO_EM_RESTART': '1', 01:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:57 INFO - 'PWD': '/builds/slave/test', 01:21:57 INFO - 'SHELL': '/bin/bash', 01:21:57 INFO - 'SHLVL': '1', 01:21:57 INFO - 'TERM': 'linux', 01:21:57 INFO - 'TMOUT': '86400', 01:21:57 INFO - 'USER': 'cltbld', 01:21:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:57 INFO - '_': '/tools/buildbot/bin/python'} 01:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:21:57 INFO - Cleaning up... 01:21:57 INFO - Return code: 0 01:21:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:21:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:21:57 INFO - Using env: {'DISPLAY': ':0', 01:21:57 INFO - 'HOME': '/home/cltbld', 01:21:57 INFO - 'LANG': 'en_US.UTF-8', 01:21:57 INFO - 'LANGUAGE': 'en_US:en', 01:21:57 INFO - 'LOGNAME': 'cltbld', 01:21:57 INFO - 'MAIL': '/var/mail/cltbld', 01:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:21:57 INFO - 'MOZ_NO_REMOTE': '1', 01:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:21:57 INFO - 'NO_EM_RESTART': '1', 01:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:21:57 INFO - 'PWD': '/builds/slave/test', 01:21:57 INFO - 'SHELL': '/bin/bash', 01:21:57 INFO - 'SHLVL': '1', 01:21:57 INFO - 'TERM': 'linux', 01:21:57 INFO - 'TMOUT': '86400', 01:21:57 INFO - 'USER': 'cltbld', 01:21:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:21:57 INFO - '_': '/tools/buildbot/bin/python'} 01:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:21:58 INFO - Downloading/unpacking psutil>=3.1.1 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:21:58 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 01:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:22:00 INFO - Installing collected packages: psutil 01:22:00 INFO - Running setup.py install for psutil 01:22:00 INFO - building 'psutil._psutil_linux' extension 01:22:00 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 01:22:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:22:00 INFO - building 'psutil._psutil_posix' extension 01:22:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:22:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:22:00 INFO - Successfully installed psutil 01:22:00 INFO - Cleaning up... 01:22:00 INFO - Return code: 0 01:22:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:22:00 INFO - Using env: {'DISPLAY': ':0', 01:22:00 INFO - 'HOME': '/home/cltbld', 01:22:00 INFO - 'LANG': 'en_US.UTF-8', 01:22:00 INFO - 'LANGUAGE': 'en_US:en', 01:22:00 INFO - 'LOGNAME': 'cltbld', 01:22:00 INFO - 'MAIL': '/var/mail/cltbld', 01:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:00 INFO - 'MOZ_NO_REMOTE': '1', 01:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:00 INFO - 'NO_EM_RESTART': '1', 01:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:00 INFO - 'PWD': '/builds/slave/test', 01:22:00 INFO - 'SHELL': '/bin/bash', 01:22:00 INFO - 'SHLVL': '1', 01:22:00 INFO - 'TERM': 'linux', 01:22:00 INFO - 'TMOUT': '86400', 01:22:00 INFO - 'USER': 'cltbld', 01:22:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:00 INFO - '_': '/tools/buildbot/bin/python'} 01:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:22:01 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 01:22:01 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 01:22:01 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 01:22:01 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 01:22:01 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 01:22:01 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 01:22:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:22:03 INFO - Installing collected packages: mozsystemmonitor 01:22:03 INFO - Running setup.py install for mozsystemmonitor 01:22:03 INFO - Successfully installed mozsystemmonitor 01:22:03 INFO - Cleaning up... 01:22:03 INFO - Return code: 0 01:22:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:22:03 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')]} 01:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:03 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')]} 01:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:03 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 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:03 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 01:22:03 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 01:22:03 INFO - Using env: {'DISPLAY': ':0', 01:22:03 INFO - 'HOME': '/home/cltbld', 01:22:03 INFO - 'LANG': 'en_US.UTF-8', 01:22:03 INFO - 'LANGUAGE': 'en_US:en', 01:22:03 INFO - 'LOGNAME': 'cltbld', 01:22:03 INFO - 'MAIL': '/var/mail/cltbld', 01:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:03 INFO - 'MOZ_NO_REMOTE': '1', 01:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:03 INFO - 'NO_EM_RESTART': '1', 01:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:03 INFO - 'PWD': '/builds/slave/test', 01:22:03 INFO - 'SHELL': '/bin/bash', 01:22:03 INFO - 'SHLVL': '1', 01:22:03 INFO - 'TERM': 'linux', 01:22:03 INFO - 'TMOUT': '86400', 01:22:03 INFO - 'USER': 'cltbld', 01:22:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:03 INFO - '_': '/tools/buildbot/bin/python'} 01:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:03 INFO - Downloading/unpacking jsonschema==2.5.1 01:22:03 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 01:22:03 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 01:22:03 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 01:22:03 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 01:22:03 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 01:22:03 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 01:22:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:22:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:05 INFO - Downloading functools32-3.2.3-2.tar.gz 01:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:22:05 INFO - warning: no files found matching '*.txt' 01:22:05 INFO - no previously-included directories found matching 'build' 01:22:05 INFO - no previously-included directories found matching 'dist' 01:22:05 INFO - no previously-included directories found matching '.git*' 01:22:05 INFO - Installing collected packages: jsonschema, functools32 01:22:05 INFO - Running setup.py install for functools32 01:22:05 INFO - warning: no files found matching '*.txt' 01:22:05 INFO - no previously-included directories found matching 'build' 01:22:05 INFO - no previously-included directories found matching 'dist' 01:22:05 INFO - no previously-included directories found matching '.git*' 01:22:05 INFO - Successfully installed jsonschema functools32 01:22:05 INFO - Cleaning up... 01:22:06 INFO - Return code: 0 01:22:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:06 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 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:06 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 01:22:06 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 01:22:06 INFO - Using env: {'DISPLAY': ':0', 01:22:06 INFO - 'HOME': '/home/cltbld', 01:22:06 INFO - 'LANG': 'en_US.UTF-8', 01:22:06 INFO - 'LANGUAGE': 'en_US:en', 01:22:06 INFO - 'LOGNAME': 'cltbld', 01:22:06 INFO - 'MAIL': '/var/mail/cltbld', 01:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:06 INFO - 'MOZ_NO_REMOTE': '1', 01:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:06 INFO - 'NO_EM_RESTART': '1', 01:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:06 INFO - 'PWD': '/builds/slave/test', 01:22:06 INFO - 'SHELL': '/bin/bash', 01:22:06 INFO - 'SHLVL': '1', 01:22:06 INFO - 'TERM': 'linux', 01:22:06 INFO - 'TMOUT': '86400', 01:22:06 INFO - 'USER': 'cltbld', 01:22:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:06 INFO - '_': '/tools/buildbot/bin/python'} 01:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:22:06 INFO - Cleaning up... 01:22:06 INFO - Return code: 0 01:22:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:06 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 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:06 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 01:22:06 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 01:22:06 INFO - Using env: {'DISPLAY': ':0', 01:22:06 INFO - 'HOME': '/home/cltbld', 01:22:06 INFO - 'LANG': 'en_US.UTF-8', 01:22:06 INFO - 'LANGUAGE': 'en_US:en', 01:22:06 INFO - 'LOGNAME': 'cltbld', 01:22:06 INFO - 'MAIL': '/var/mail/cltbld', 01:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:06 INFO - 'MOZ_NO_REMOTE': '1', 01:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:06 INFO - 'NO_EM_RESTART': '1', 01:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:06 INFO - 'PWD': '/builds/slave/test', 01:22:06 INFO - 'SHELL': '/bin/bash', 01:22:06 INFO - 'SHLVL': '1', 01:22:06 INFO - 'TERM': 'linux', 01:22:06 INFO - 'TMOUT': '86400', 01:22:06 INFO - 'USER': 'cltbld', 01:22:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:06 INFO - '_': '/tools/buildbot/bin/python'} 01:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:06 INFO - Downloading/unpacking blobuploader==1.2.4 01:22:06 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 01:22:06 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 01:22:06 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 01:22:06 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 01:22:06 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 01:22:06 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 01:22:08 INFO - Downloading blobuploader-1.2.4.tar.gz 01:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:22:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:22:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:22:09 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 01:22:09 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 01:22:09 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 01:22:09 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 01:22:09 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 01:22:09 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 01:22:09 INFO - Downloading docopt-0.6.1.tar.gz 01:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:22:09 INFO - Installing collected packages: blobuploader, requests, docopt 01:22:09 INFO - Running setup.py install for blobuploader 01:22:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:22:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:22:09 INFO - Running setup.py install for requests 01:22:09 INFO - Running setup.py install for docopt 01:22:09 INFO - Successfully installed blobuploader requests docopt 01:22:09 INFO - Cleaning up... 01:22:10 INFO - Return code: 0 01:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:22:10 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')]} 01:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:10 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')]} 01:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:10 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 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:10 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 01:22:10 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 01:22:10 INFO - Using env: {'DISPLAY': ':0', 01:22:10 INFO - 'HOME': '/home/cltbld', 01:22:10 INFO - 'LANG': 'en_US.UTF-8', 01:22:10 INFO - 'LANGUAGE': 'en_US:en', 01:22:10 INFO - 'LOGNAME': 'cltbld', 01:22:10 INFO - 'MAIL': '/var/mail/cltbld', 01:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:10 INFO - 'MOZ_NO_REMOTE': '1', 01:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:10 INFO - 'NO_EM_RESTART': '1', 01:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:10 INFO - 'PWD': '/builds/slave/test', 01:22:10 INFO - 'SHELL': '/bin/bash', 01:22:10 INFO - 'SHLVL': '1', 01:22:10 INFO - 'TERM': 'linux', 01:22:10 INFO - 'TMOUT': '86400', 01:22:10 INFO - 'USER': 'cltbld', 01:22:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:10 INFO - '_': '/tools/buildbot/bin/python'} 01:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:22:10 INFO - Running setup.py (path:/tmp/pip-8YeDkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:22:10 INFO - Running setup.py (path:/tmp/pip-6EXx04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:22:10 INFO - Running setup.py (path:/tmp/pip-DNBUR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:22:10 INFO - Running setup.py (path:/tmp/pip-74fgWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:22:10 INFO - Running setup.py (path:/tmp/pip-uMWUed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:22:10 INFO - Running setup.py (path:/tmp/pip-0bQJXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:22:10 INFO - Running setup.py (path:/tmp/pip-RVSbeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:22:10 INFO - Running setup.py (path:/tmp/pip-bNMKGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:22:10 INFO - Running setup.py (path:/tmp/pip-HKRqEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:22:10 INFO - Running setup.py (path:/tmp/pip-TEKvbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:22:10 INFO - Running setup.py (path:/tmp/pip-oujLiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:22:11 INFO - Running setup.py (path:/tmp/pip-vbpumM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:22:11 INFO - Running setup.py (path:/tmp/pip-ZcHXIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:22:11 INFO - Running setup.py (path:/tmp/pip-cIksCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:11 INFO - Running setup.py (path:/tmp/pip-3bs2eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:22:11 INFO - Running setup.py (path:/tmp/pip-EukV2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:22:11 INFO - Running setup.py (path:/tmp/pip-w7O_kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:22:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:22:11 INFO - Running setup.py install for manifestparser 01:22:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:22:11 INFO - Running setup.py install for mozcrash 01:22:11 INFO - Running setup.py install for mozdebug 01:22:11 INFO - Running setup.py install for mozdevice 01:22:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:22:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:22:11 INFO - Running setup.py install for mozfile 01:22:12 INFO - Running setup.py install for mozhttpd 01:22:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for mozinfo 01:22:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for mozInstall 01:22:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for mozleak 01:22:12 INFO - Running setup.py install for mozlog 01:22:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for moznetwork 01:22:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for mozprocess 01:22:12 INFO - Running setup.py install for mozprofile 01:22:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for mozrunner 01:22:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:22:12 INFO - Running setup.py install for mozscreenshot 01:22:13 INFO - Running setup.py install for moztest 01:22:13 INFO - Running setup.py install for mozversion 01:22:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:22:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:22:13 INFO - Cleaning up... 01:22:13 INFO - Return code: 0 01:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:13 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 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:13 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 01:22:13 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 01:22:13 INFO - Using env: {'DISPLAY': ':0', 01:22:13 INFO - 'HOME': '/home/cltbld', 01:22:13 INFO - 'LANG': 'en_US.UTF-8', 01:22:13 INFO - 'LANGUAGE': 'en_US:en', 01:22:13 INFO - 'LOGNAME': 'cltbld', 01:22:13 INFO - 'MAIL': '/var/mail/cltbld', 01:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:13 INFO - 'MOZ_NO_REMOTE': '1', 01:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:13 INFO - 'NO_EM_RESTART': '1', 01:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:13 INFO - 'PWD': '/builds/slave/test', 01:22:13 INFO - 'SHELL': '/bin/bash', 01:22:13 INFO - 'SHLVL': '1', 01:22:13 INFO - 'TERM': 'linux', 01:22:13 INFO - 'TMOUT': '86400', 01:22:13 INFO - 'USER': 'cltbld', 01:22:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:13 INFO - '_': '/tools/buildbot/bin/python'} 01:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:22:13 INFO - Running setup.py (path:/tmp/pip-qEqDH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:22:13 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)) 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:22:13 INFO - Running setup.py (path:/tmp/pip-io6P5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:22:13 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)) 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:22:13 INFO - Running setup.py (path:/tmp/pip-kD7jP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:22:13 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)) 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:22:13 INFO - Running setup.py (path:/tmp/pip-n8G3vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:22:13 INFO - Running setup.py (path:/tmp/pip-RhL2Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:22:13 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)) 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:22:13 INFO - Running setup.py (path:/tmp/pip-aPy69I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:22:13 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)) 01:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:22:13 INFO - Running setup.py (path:/tmp/pip-2X5TvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:22:14 INFO - Running setup.py (path:/tmp/pip-cxmNSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:22:14 INFO - Running setup.py (path:/tmp/pip-llWN1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:22:14 INFO - Running setup.py (path:/tmp/pip-aablRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:22:14 INFO - Running setup.py (path:/tmp/pip-dspSsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:22:14 INFO - Running setup.py (path:/tmp/pip-WLduhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:22:14 INFO - Running setup.py (path:/tmp/pip-ytIeiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:22:14 INFO - Running setup.py (path:/tmp/pip-m6O_dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:14 INFO - Running setup.py (path:/tmp/pip-AVVxIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:14 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:22:14 INFO - Running setup.py (path:/tmp/pip-ZsKW2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 01:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:22:14 INFO - Running setup.py (path:/tmp/pip-j6_Znz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:22:14 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)) 01:22:14 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)) 01:22:14 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)) 01:22:14 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)) 01:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:22:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:22: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 01:22: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 01:22: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 01:22: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 01:22: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 01:22: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 01:22:16 INFO - Downloading blessings-1.6.tar.gz 01:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:22:16 INFO - Installing collected packages: blessings 01:22:16 INFO - Running setup.py install for blessings 01:22:16 INFO - Successfully installed blessings 01:22:16 INFO - Cleaning up... 01:22:17 INFO - Return code: 0 01:22:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:22:17 INFO - Reading from file tmpfile_stdout 01:22:17 INFO - Current package versions: 01:22:17 INFO - argparse == 1.2.1 01:22:17 INFO - blessings == 1.6 01:22:17 INFO - blobuploader == 1.2.4 01:22:17 INFO - docopt == 0.6.1 01:22:17 INFO - functools32 == 3.2.3-2 01:22:17 INFO - jsonschema == 2.5.1 01:22:17 INFO - manifestparser == 1.1 01:22:17 INFO - mozInstall == 1.12 01:22:17 INFO - mozcrash == 1.0 01:22:17 INFO - mozdebug == 0.1 01:22:17 INFO - mozdevice == 0.48 01:22:17 INFO - mozfile == 1.2 01:22:17 INFO - mozhttpd == 0.7 01:22:17 INFO - mozinfo == 0.9 01:22:17 INFO - mozleak == 0.1 01:22:17 INFO - mozlog == 3.4 01:22:17 INFO - moznetwork == 0.27 01:22:17 INFO - mozprocess == 0.23 01:22:17 INFO - mozprofile == 0.28 01:22:17 INFO - mozrunner == 6.13 01:22:17 INFO - mozscreenshot == 0.1 01:22:17 INFO - mozsystemmonitor == 0.3 01:22:17 INFO - moztest == 0.8 01:22:17 INFO - mozversion == 1.4 01:22:17 INFO - psutil == 3.1.1 01:22:17 INFO - requests == 1.2.3 01:22:17 INFO - wsgiref == 0.1.2 01:22:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:22: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')]} 01:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22: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')]} 01:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:17 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 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22:17 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 01:22:17 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 01:22:17 INFO - Using env: {'DISPLAY': ':0', 01:22:17 INFO - 'HOME': '/home/cltbld', 01:22:17 INFO - 'LANG': 'en_US.UTF-8', 01:22:17 INFO - 'LANGUAGE': 'en_US:en', 01:22:17 INFO - 'LOGNAME': 'cltbld', 01:22:17 INFO - 'MAIL': '/var/mail/cltbld', 01:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:17 INFO - 'MOZ_NO_REMOTE': '1', 01:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:17 INFO - 'NO_EM_RESTART': '1', 01:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:17 INFO - 'PWD': '/builds/slave/test', 01:22:17 INFO - 'SHELL': '/bin/bash', 01:22:17 INFO - 'SHLVL': '1', 01:22:17 INFO - 'TERM': 'linux', 01:22:17 INFO - 'TMOUT': '86400', 01:22:17 INFO - 'USER': 'cltbld', 01:22:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:17 INFO - '_': '/tools/buildbot/bin/python'} 01:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 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)) 01:22:17 INFO - Cleaning up... 01:22:17 INFO - Return code: 0 01:22:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:22: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')]} 01:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22: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')]} 01:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42070ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16caca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', '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 01:22: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', 'jsonschema'] in /builds/slave/test/build 01:22: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 jsonschema 01:22:17 INFO - Using env: {'DISPLAY': ':0', 01:22:17 INFO - 'HOME': '/home/cltbld', 01:22:17 INFO - 'LANG': 'en_US.UTF-8', 01:22:17 INFO - 'LANGUAGE': 'en_US:en', 01:22:17 INFO - 'LOGNAME': 'cltbld', 01:22:17 INFO - 'MAIL': '/var/mail/cltbld', 01:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:17 INFO - 'MOZ_NO_REMOTE': '1', 01:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:17 INFO - 'NO_EM_RESTART': '1', 01:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:17 INFO - 'PWD': '/builds/slave/test', 01:22:17 INFO - 'SHELL': '/bin/bash', 01:22:17 INFO - 'SHLVL': '1', 01:22:17 INFO - 'TERM': 'linux', 01:22:17 INFO - 'TMOUT': '86400', 01:22:17 INFO - 'USER': 'cltbld', 01:22:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:17 INFO - '_': '/tools/buildbot/bin/python'} 01:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:22:17 INFO - Cleaning up... 01:22:17 INFO - Return code: 0 01:22:17 INFO - Running post-action listener: _resource_record_post_action 01:22:17 INFO - Running post-action listener: _start_resource_monitoring 01:22:17 INFO - Starting resource monitoring. 01:22:17 INFO - [mozharness: 2017-01-09 09:22:17.720663Z] Finished create-virtualenv step (success) 01:22:17 INFO - [mozharness: 2017-01-09 09:22:17.721113Z] Running install step. 01:22:17 INFO - Running pre-action listener: _resource_record_pre_action 01:22:17 INFO - Running main action method: install 01:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:22:17 INFO - Reading from file tmpfile_stdout 01:22:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:22:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:22:17 INFO - Reading from file tmpfile_stdout 01:22:17 INFO - Output received: 01:22:17 INFO - Usage: mozinstall [options] installer 01:22:17 INFO - Options: 01:22:17 INFO - -h, --help show this help message and exit 01:22:18 INFO - -d DEST, --destination=DEST 01:22:18 INFO - Directory to install application into. [default: 01:22:18 INFO - "/builds/slave/test"] 01:22:18 INFO - --app=APP Application being installed. [default: firefox] 01:22:18 INFO - mkdir: /builds/slave/test/build/application 01:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:22:33 INFO - Reading from file tmpfile_stdout 01:22:33 INFO - Output received: 01:22:33 INFO - /builds/slave/test/build/application/firefox/firefox 01:22:33 INFO - Running post-action listener: _resource_record_post_action 01:22:33 INFO - [mozharness: 2017-01-09 09:22:33.969534Z] Finished install step (success) 01:22:33 INFO - [mozharness: 2017-01-09 09:22:33.969778Z] Running run-tests step. 01:22:33 INFO - Running pre-action listener: _resource_record_pre_action 01:22:33 INFO - Running main action method: run_tests 01:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:22:33 INFO - Python 2.7.3 01:22:33 INFO - Return code: 0 01:22:33 INFO - grabbing minidump binary from tooltool 01:22: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')]} 01:22:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c7f60>, '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 0x16c8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:22:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:22:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:22:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:22:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:22:34 INFO - Return code: 0 01:22:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:22:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:22:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:22:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:22:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 01:22:34 INFO - Using env: {'DISPLAY': ':0', 01:22:34 INFO - 'HOME': '/home/cltbld', 01:22:34 INFO - 'LANG': 'en_US.UTF-8', 01:22:34 INFO - 'LANGUAGE': 'en_US:en', 01:22:34 INFO - 'LOGNAME': 'cltbld', 01:22:34 INFO - 'MAIL': '/var/mail/cltbld', 01:22:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:22:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:34 INFO - 'MOZ_NO_REMOTE': '1', 01:22:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:34 INFO - 'NO_EM_RESTART': '1', 01:22:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:34 INFO - 'PWD': '/builds/slave/test', 01:22:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:22:34 INFO - 'SHELL': '/bin/bash', 01:22:34 INFO - 'SHLVL': '1', 01:22:34 INFO - 'TERM': 'linux', 01:22:34 INFO - 'TMOUT': '86400', 01:22:34 INFO - 'USER': 'cltbld', 01:22:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232', 01:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:34 INFO - '_': '/tools/buildbot/bin/python'} 01:22:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 01:22:34 INFO - mozversion application_buildid: 20170108234108 01:22:34 INFO - mozversion application_changeset: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 01:22:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:22:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:22:34 INFO - mozversion application_name: Firefox 01:22:34 INFO - mozversion application_remotingname: firefox-dev 01:22:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:22:34 INFO - mozversion application_vendor: Mozilla 01:22:34 INFO - mozversion application_version: 52.0a2 01:22:34 INFO - mozversion platform_buildid: 20170108234108 01:22:34 INFO - mozversion platform_changeset: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 01:22:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:22:34 INFO - mozversion platform_version: 52.0a2 01:22:34 INFO - using testdate: 1483953754 01:22:34 INFO - actual date: 1483953754 01:22:34 INFO - starting webserver on 'localhost:60114' 01:22:34 INFO - SUITE-START | Running 2 tests 01:22:34 INFO - TEST-START | dromaeo_css 01:22:34 INFO - operating with platform_type : linux_ 01:22:34 INFO - Initialising browser for dromaeo_css test... 01:22:34 INFO - TEST-INFO | started process 14369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFCxnT/profile http://localhost:60114/getInfo.html) 01:22:37 INFO - PROCESS | 14369 | __metrics Screen width/height:1600/1200 01:22:37 INFO - PROCESS | 14369 | colorDepth:24 01:22:37 INFO - PROCESS | 14369 | Browser inner width/height: 1024/697 01:22:37 INFO - PROCESS | 14369 | __metrics 01:22:38 INFO - PROCESS | 14369 | 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" 01:22:38 INFO - PROCESS | 14369 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:22:38 INFO - PROCESS | 14369 | console.error: PushService: 01:22:38 INFO - PROCESS | 14369 | stateChangeProcessEnqueue: Error transitioning state 01:22:38 INFO - PROCESS | 14369 | UnknownError 01:22:39 INFO - TEST-INFO | 14369: exit 0 01:22:39 INFO - Browser initialized. 01:22:39 INFO - Running cycle 1/1 for dromaeo_css test... 01:22:39 INFO - TEST-INFO | started process 14462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFCxnT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:50 INFO - PROCESS | 14462 | RSS: Main: 144297984 01:22:50 INFO - PROCESS | 14462 | 01:25:52 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:60114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60114/tests/dromaeo/cssquery-ext.html) 01:25:53 INFO - PROCESS | 14462 | RSS: Main: 251973632 01:25:53 INFO - PROCESS | 14462 | 01:28:56 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:60114/tests/dromaeo/cssquery-ext.html (next: http://localhost:60114/tests/dromaeo/cssquery-jquery.html) 01:28:56 INFO - PROCESS | 14462 | RSS: Main: 232566784 01:28:56 INFO - PROCESS | 14462 | 01:31:58 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:60114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60114/tests/dromaeo/cssquery-mootools.html) 01:31:59 INFO - PROCESS | 14462 | RSS: Main: 214433792 01:31:59 INFO - PROCESS | 14462 | 01:35:01 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:60114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60114/tests/dromaeo/cssquery-prototype.html) 01:35:01 INFO - PROCESS | 14462 | RSS: Main: 218861568 01:35:01 INFO - PROCESS | 14462 | 01:38:04 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:60114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60114/tests/dromaeo/cssquery-yui.html) 01:38:05 INFO - PROCESS | 14462 | RSS: Main: 176234496 01:38:05 INFO - PROCESS | 14462 | 01:41:07 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:60114/tests/dromaeo/cssquery-yui.html (next: http://localhost:60114/tests/dromaeo/cssquery-dojo.html) 01:41:08 INFO - PROCESS | 14462 | RSS: Main: 269148160 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | __start_tp_report 01:41:08 INFO - PROCESS | 14462 | _x_x_mozilla_page_load 01:41:08 INFO - PROCESS | 14462 | _x_x_mozilla_page_load_details 01:41:08 INFO - PROCESS | 14462 | |i|pagename|runs| 01:41:08 INFO - PROCESS | 14462 | |0;dojo.html;3237.7733558650893;3271.2149084219777;3272.083816531371;3295.785773924696;3303.9008829735117;5599.692016939067;5707.258056452661;5724.2558467399285;5729.856753581163;5732.111522713986;5711.400302968181;5766.509846663028;5769.538436925046;5777.393373695754;5778.075507918734;5209.192575150839;5225.503577160163;5232.659877107976;5249.343832020997;5299.655522391052;5005.849824505271;5307.363116426034;5307.628466007381;5319.015982043315;5344.946550534483;5013.523715247045;5045.672031317952;5070.898582028357;5085.872853178663;5114.156164232897;5140.049090918192;5182.7408629568745;5191.480851914816;5252.212168174766;5268.631195816294;4929.137400954819;5085.338905942203;5169.4313625501545;5197.766100525486;5198.2722418861385;5433.673979561239;5543.057680194336;5543.473370029841;5565.721713914288;5595.048841696921;5997.190379298782;5998.340182579913;6085.574009819315;6115.9694201529155;6121.387861213888;5793.65238085712;6153.446189842935;6163.19878415803;6173.845653858644;6176.980798168297;5473.343198816127;5525.143602741541;5555.444455554412;5570.6657600544095;5609.467100625434;6109.480694140959;6112.358202388685;6117.480014198754;6122.663253521099;6134.2332208473945;5742.454466825645;5788.247527821356;5870.354261031283;5872.031114866085;5890.617109887844;5960.910586341209;6043.033114701714;6051.606645568024;6052.878942421127;6053.4551890330085;6007.729652165663;6017.548683848641;6018.548608854266;6020;6060.272767267956;5970.940290597038;6018.337982821886;6028.125921741323;6031.396860313934;6034.9396506035255;4521.163584736834;4521.344405061248;4644;4644.790984405709;4679.087577922272;4158.750474971512;4173.478315210598;4185.100203456272;4215.662746980234;4232.597903199191;5733.397993210736;5738.598298119092;5739.598228124075;5744.684042377709;5745.052066409079;5863.2670916135485;5905.232319798399;5933.376995415506;5980.372060933626;6066.848328791727;5659.745311460994;5677.659340439504;5683.914741278884;5685.1756495307945;5708.743106560215;5236.502532259429;5255.421903590602;5255.947440525546;5257.342832145981;5286.550643195372;5961.731722072431;6014.72933717975;6083.239595050619;6103.42017508336;6127.448529632355;6049.818505444844;6058.12157237207;6064.241969753781;6066.393360663898;6090.2996155440915;6174.6424957758645;6193;6207.534434917489;6212.658303793335;6223.315435302023;5798.420157984337;5842.766289348378;5915.438033386821;5980.222571065734;6012.939870601238;6003.759849606142;6144.863200307957;6150.569460137926;6154.476869466145;6164.044573091178;5946.791862284799;5957.523398128226;6012;6022.427869352405;6025.6083354581815;5634.408387119457;5672.319321681424;5987.341392446914;5993.9700301498215;5998.640081595118;5824.94175058244;5867.149263356875;5871.853203669943;5970.044792833126;5985.431384018511;5995.46040856325;6002.639841609517;6014.518838492998;6015.909761353496;6016.977113890562;5646.745896434588;5698.2592263005545;5705.115707065412;5859.824205273849;5870.442307980735 01:41:08 INFO - PROCESS | 14462 | |1;ext.html;579.6174524813624;619.8047615001274;630.4704048599177;658.3975662269024;660.857915548157;34388.1402964926;40643;40927.38608920869;41168.588314116925;41208;46563.30155047669;46994.99999999991;47070.76464617681;47076.29385559211;47111.29333060007;8373.62318695657;8739.300855931526;8901;8904.243139333132;8910.465372077664;8370.958145209266;8677.045524992245;8685.0880657531;10594.046535811776;10849.349039057683;10989.450527473635;11043.116550675926;11043.447827608628;11052.115830733563;11057;10857.23999320048;10915.563377464892;10922.726931826688;10939.45302734868;10942.45287735614;10737.731556711067;10781.730456738644;10794.892051079467;10801.40592267425;10804.621838235624;43865.561344386464;44256.778716106535;44315.77842110769;44402.333964990554;44403.333949990774;3657.8353974070965;3791.109089363997;3814;4025.376066709665;4426.247537918562;32672.836635816668;33038.50442243368;33487;33778.831105844314;34561.82719086413;4447.5552444755585;4491.820327186909;4501.392312037866;4579.519150489217;4698.201305778026;336590;338812;339919;341159;342056;38047.42928856069;60696.696516518015;61338;61386.69306653438;61387.69306153441;38898;40952.79523602423;41172.1765564687;41268.38097428541;41280.79359603183;15003.249837508081;15016.624584385478;15091.24543772807;15137.697246055237;15151.090934543963;10761.246712730033;12943.093983421259;13074.411651475517;13206.47174113044;13208.141470804367;8890.244329231959;9194.494302813277;9431.622735090657;9476.763080922894;9593.568289426992;3585.731070169748;3599.6040435552068;3600.747947643692;3623.4202527595457;3635.2729454109285;1028.1774580335702;1037.4242295525905;1050.9632162874263;1111.366521082991;1217.9756404871853;33601.15997100092;33735.493967590504;34655.480167797505;34660.6135754567;34875.128121797155;1126.9098472122212;1135.28477059452;1192.0820967854704;1261.8548866880426;1268.7145392286845;17128.229229684694;17156.22796974139;17178.74231886523;17312.22095005728;17366.39217627377;493768;498730;499200;499607;500510;58355.416445835;58851.41148588459;58857;58868;58908.11637825436;1323.0606269548537;1370.2463644995212;1447.9420823166956;1462.7586448236134;1479.7928290039404;30475.695243047285;33477.49783753197;34444.65555344414;34566;34665;51891.740541297055;58333.708331458074;60075.69962150161;60104.69947650409;65506;472076;472171;475111;475158;477708;31034.98272612363;32414.189645259055;32555.837220813744;32855.67144328622;33100.33799323952;50991;50992;51031.744841275555;51074.74462627663;51298.74350628223;42269.577304227794;42441;42729;43629;43885;41308.79345603253;41443.7927810359;42295.57704422916;43670;45498.54501454943;44257.33613995857;44410.11179776322;44588.55411445844;44649.776751116035;44764.32853507135;36728.63271367252;38674.80662596669;38880.80559597184;39337.40993885037;39668.40497392484;29606.55590166106;29802.85098574493;29901.252468688457;30044.549331759605;30166.396672066876 01:41:08 INFO - PROCESS | 14462 | |2;jquery.html;392.46232661254083;424.5267197884075;429.4352925902438;436.66595054783085;438.65565531058127;15916.92041539792;18873.433796986094;20328.49178770528;20586;20701.585968280644;20201.19195232189;20428.59142817143;20492.385228443134;20625.1749930003;20668.586628267425;5715.114157305614;5813.82558523245;5941.910871336933;5943.55423343251;5945.970270148643;5760.56795740319;5933.495652869511;5951.970240148815;5956.404359564052;5961.225040744697;5754.597178197528;5905.793297234598;5912.142739302799;5924.348321684612;5927.703614819264;5899.616524925866;6064.241969753781;6081.908771368433;6083.874483220597;6084.99597566401;5925.34821169671;5927.051671732545;6728.93271067288;7153.4620056687545;7207.45944054198;25418.74581254201;25603.871980640164;27174.45651086987;27252.182434526996;27442.451150976867;2547.8598677072755;2688.1263589333544;2746.231055304518;2890.421915616885;3272.361889431562;15768.211589420484;16266.349346026145;16298.185090745415;16587.170641467877;17003.74494382585;2131.82945364372;2232.810211132056;2253.053717438663;2266.5806825737127;2279.806216471602;99435;102484;102982.48508757408;104441.99999999924;104616.47691761568;14744.894132940073;18001.376721520857;18637.90681046586;18804.623907521775;18980.43058708241;27789.861050694617;28535.429291414057;28576.571351429746;28590;28612.57081143743;9970.501474926225;10334.276600638033;10345.275830691779;10413.479326033668;10532.894671053346;8588.8711669325;8610.440321379216;8680.30557555394;8854.513001784835;8854.64581416749;9088.863667045;9193.402428842104;9337.486438245825;9360.4383736976;9377.484238366818;3282.8030318180986;3298.736101111905;3589.6410358964417;3633.982484904231;3634.3821550336506;967.4920666650065;970.5583959298502;1000.3247807729754;1010.7018429563296;1015.8120747661559;19626.509337266398;19807.900960495106;19825.20699172017;19998.20007199696;20007.59984800325;1000.4997501249376;1003.9899601004042;1015.8476228565775;1025.2669341420772;1038.7143535527791;10417.739556511147;11074.39090850011;11096.944515277371;11159.442027898735;11171.72070698239;362214;365699;368270;492352;493614;57465.71267143721;58969;59300;59359.40640593539;83944;1060.2949038889053;1062.9787404252027;1073.3398959639765;1100.4497751124438;1109.417555783204;17385.739213911547;17730.379436719653;17765.200565974304;17953.10234488244;18306.450806475827;31095.844520777253;33131.668683312855;41142.79428602838;42843;44028.559714403724;55420;57633.84732305414;59268.40731592629;60050.699746500984;60723.089153661844;7841.764747057598;8367.790805229917;8553.230209281195;8614.82770344602;9017.053209412918;10363.689089327332;13066.477340906638;13156.144850584682;13592.66018349549;14012.579622611338;11918.582849600223;11934.880651193724;11968.222065565711;12136.635900922987;12227;11752.647420577396;11875.821862671894;11996.100292477924;12065;12434.937825310815;12131.332776697014;12179;12274.386280686109;12601.18092323996;12897;9108.772280693036;9120.02227791692;9213.262938965001;9405.576749046173;9491.240700744062;8932.910670893209;11890.28658280506;12030.398480075786;12354.382280886099;12586.496540138658 01:41:08 INFO - PROCESS | 14462 | |3;mootools.html;1451.0785651111544;1508.9849101508985;1604.8314926932671;1723.4140392266627;1734.523006173303;7967.40244481664;8477.533735644538;8480.279176270009;8488.23605875471;8489;7426.443016773736;7635.580043097628;8008.67965281388;8150.021997360325;8172.1827817218245;2416.1664225842055;2420.20133355993;2435.476372579895;2436.8903399347073;2438.1588352018525;2411.927642170729;2448.9877550612223;2498.3254521279246;2498.9875050624723;2501.162110692911;2070.8550401471903;2139.4330502416874;2139.6148693235214;2150.2151714624206;2365.314058922919;2438.9146379876706;2485.3662316109367;2493.6010238361773;2495.3137887081016;2497.9750202497926;2406.783389494954;2435.8538487690794;2444.9511009779703;2446.584080706284;2447.3514518652573;8284.544350060743;8409.621567029499;8480.982282126122;8481.363897707635;8493.702720404755;5224.712640804754;5360.195970604402;5362.142057270857;5363.410024897258;5364.597655175839;3237.87048518059;3425.486177073434;3466.9306613867834;3479.6694314040124;3497.3704733148024;1024.4928760263642;1109.572814466428;1115.7433790228292;2046.7339245898088;2161.243564752324;11551.884481155164;11597.188196826226;11646.883531164665;11675.532978680927;11680.474378652982;4380.78096095194;4543.091381723669;4617.976910115428;4620.792064357112;4704.0356726870905;9075.954620226988;9077.909220907839;9080.772980675536;9090.772730681785;9098.363114582047;5352.063388906926;5355.625106242604;5357.785688572491;5363.846772943836;5366.91949620756;4833.9033219335415;4987.202047672355;5024.271480635288;5027.195648696191;5048.697078175322;3660.396034654252;3688.7602305850032;3755.6244375562223;3785.299719551892;3786.848526058982;1166.7083229192701;1179.4279774309452;1180.7461395799944;1183.4792691215837;1196.0491409329604;961.1205746741792;995.0447570332561;1002.4937406609761;1002.7493126718321;1004.1314263162312;5836.761937019967;5843.415658434207;5865.677387743715;5885.705714714247;6036;495.23238979581504;503.87151276424277;513.3916309173641;515.1500024958773;519.2600544224465;4083.5508094109623;4172.186423647359;4197.790110494524;4259.936100958488;4289.1850548395705;10090.44502552352;10466.319689220329;10474.057334839901;10486.475676216158;10489.527971241312;10410.739731506774;10412.479376031168;10425.165986721044;10426.843597346045;10469.37183768961;7781.45529812919;7831;7883.526988380716;7959.761207163794;7982.840343193104;5674.74463649145;5746.367899531132;5857;5875.764969401176;5882.5293976480925;9139.862902056608;9216.032316606928;9315.301352398461;9327.393719408217;9342.906570934203;9544.188743956563;9643.807123857623;9644.517774111126;9656.71029869105;9656.806863862825;6946.16646002483;7046.929530704832;7054.541454805421;7055.717771289091;7058.611776352144;7767.766966990999;7906.288434040964;7952.880706789519;8079.636416361161;8162.7143049992965;7302.306280903305;7336.156342020736;7372.668229929774;7392.667329970057;7636;7202.351788339075;7340.596267205355;7370.226126256666;7398.96300518494;7420.6660700269695;6847.315268473113;6872.965635171792;6957.617331046638;6962;6983.895241571279;5148.897022059613;5176.4047134580005;5262.710550919583;5263.763130659206;5320.627556071038;5114.923276150935;5171.974140129275;5177.4822517749435;5205.297284866495;5304.416514183359 01:41:08 INFO - PROCESS | 14462 | |4;prototype.html;325.1108219020979;350.95086687863704;356.63444968906873;357.292560729755;364.8923567547573;5249.186376111699;5302.761375738091;5349.358077030762;5441.83674489766;5461.290032295796;5336.557920141507;5360.249565060885;5370.060239458089;5420.915816836628;5429.348478182624;4285.785710714467;4292.549282325358;4302.913941721179;4317.611414972652;4322.675799315064;4101.2617728808955;4188.685848561355;4248.447701798762;4311.180875633635;4331.675124365669;4267.509236437802;4278.486581610196;4285.892852678692;4287.31402975524;4292.806823692941;4275.144971005796;4276.123394704078;4279.33670281107;4283.50077472882;4288.869125538375;3763;3826.005238637946;3860.478835357219;3861.555921069085;3863.323918314312;5227.712475813829;5255.710935898524;5260.973695131538;5261.579073674096;5291.497307755757;4897.51024897511;4897.681650692693;4897.951020489785;4908;4909.852704418838;5536.833894983157;5568.916466252969;5627.634203776742;5649.943500564983;5669.688167150805;4188.790560471964;4188.832446702128;4190.51809041961;4199.832006719727;4203.453551038376;5858.736356863908;5859.9783074839115;5860.714321414652;5874.265716785402;5887.528997680175;4199.91600167995;4273;4289.699721019499;4300.483941926988;4317.222899878052;4331.80506877185;4334.523202447728;4352.847650332224;4360.869173924787;4374.190774706626;4592.15045216636;4733.5266473352385;4744;4746.572808447257;4767;5537.667739935617;5665.773369065274;5688.728980836036;5695.259616249861;5705.372409035002;1408.7393832141086;1462.9612974787808;1463.3341829467568;1467.2150399536197;1474.3954978458994;1023.9299931571526;1031.4584842957358;1041.2450973044633;1043.4417586591137;1043.9478026098664;5274.498922602346;5281.705982034349;5286.5506431952945;5347.86630334237;5353.866153346197;5642;5645.407232240637;5653.830385088454;5661.235733176051;5671;5235.701508049904;5507.697076660822;5520.282363292747;5535.501804837584;5539.1997600779905;2978.5234362501897;2996.955045674317;2998.9100326990224;3001.7392695068124;3013.9397212055637;5607.906228453252;5705.486506214377;5710.885782284414;5748.683822389725;5748.872917020729;5742.856428589235;5754.367019627837;5761.279840019997;5770.6249093808765;5789.160571717078;5716.228309178291;5725.112607545837;5725.742341594555;5741.74162162712;5744.540436765049;5379.946200537945;5595.8880822384135;5600.327960644749;5616.38219795814;5626.943730562642;5553.6390134641115;5582.8325150245555;5592.636478629039;5610.943890561042;5611.607187496836;5595.356533998643;5707.971460142673;5710.857828434247;5718.313802343745;5932.2584676915385;4249.55379685141;4280.72175308604;4292.3561465780385;4309.525952145199;4311.633511151462;5634.74643641029;5724.255846740064;5816.208220054482;5894.793682221101;5924.200232968494;5734.7061175530125;5741.339745929272;5742.253507044057;5754.5684073695475;5755.1367294906095;5599.160125981135;5705.714714264187;5707.315122185364;5742.942570574241;5752;5618.578606604439;5665.943340566541;5685.943140568541;5692.459216374438;5711.428857114255;5652.4064973178865;5685.715714214355;5740.650947027361;5740.823131257998;5749.8275051748515;5423.674579525241;5585.162225666182;5601.383847776823;5625.662460252398;5626.465485778845 01:41:08 INFO - PROCESS | 14462 | |5;yui.html;811.5212024905304;829.5313148071343;854.2013217641505;854.4360721923531;877.5261358866212;14059.156450612958;14999.700005999874;15283.388664453436;15291.694166116671;15316.081035137886;14661;14812.555623331291;14949.775753363681;14953.177575233358;15003.849961500382;732.0739264829967;856.2422256303186;868.7784614923186;869.387082107113;869.5130726792985;726.3100054947794;735.4667865797308;735.6615956659916;849.142366210126;861.7802460372596;886.0430734806394;903.223228023899;903.2728653434016;903.941243819153;904.2178515584005;897.3539051882634;897.5287973813735;898.348697194532;898.7079199260202;898.8067565473422;559.2226804741372;567.6452217364148;570.1561688700746;668.906353110565;671.6071098407438;12424.130310878241;13886.166829990132;14220.786688199685;14260.14439133645;14903.254837258093;15070.397184112622;15216.695666086727;15682.68634627301;15762.211889405484;15797.131157786318;11885.168038237327;11954.163208575403;11988;12099.274043557414;12189.634310970685;3882.514685664292;3893.3575959966856;3937.822797974098;3946.8026598669953;3994.520657521116;64903.67548162229;65956.67021664909;66271.66864165697;66391.66804165948;68289;10712.73218169552;10751.677449676523;10852.620158294421;10925.125989920787;11228.326300422;22121.44696382571;22158.667619985714;22172.113115475524;22194.334169974925;22361.55276894453;8319.251267385844;8344.62449189788;8498.320134389234;8630;8669.566521674018;4393.033532622818;4611.746353950565;4657.69724967876;4767.332573439652;4793.209120495079;3485.5643044619424;3602.45963105531;3602.819859007039;3604.8377822998027;3613.259281847215;581.4650521520211;594.4145017158096;595.5384576952896;609.6281268426256;650.7006776882592;738.7746737245192;756.239978821281;757.5984728094119;766.8006318357267;778.4550814429922;9248.26013918885;9374.85937710935;9474.289428292906;10131.189504839595;10149.594016239416;631.400169838646;666.849958759285;735.1876176824532;739.3235189801271;751.7819832248587;4591.242444996605;4637.582617564435;4734.502877197913;4822.324874517571;4863.878403039882;88261.55869220741;93467.53266233625;94230.52884735669;94243.52878235564;95400.52299738457;49539;64934;78975.60512197402;79515.20484795078;79774.60112699516;67586.324136758;68510.65744671244;68947;69182;69428;8779.956100219459;8894.4663320201;8989.685361012333;9095.317851161057;9127.359776375532;49899;50732;50746;51192.74403628107;52585.7370713144;64248;68711.65644171747;70137.64931175312;70486.64756676184;73188.63405682938;11539.942300288445;11719.472623732123;11730.12024098213;11812;11952;12964.481420743441;12968.546100886424;13091.083624146599;13262.27057511846;13961.860381396056;11744.530218791153;11777.234479758788;11878.82181767257;12204.08469364819;12573.371331433575;12381.319027453215;12760.106792524433;12790.61628151157;13294.401751920994;13308.600741977756;11697.649070527897;11806.350650714294;11993.040556755614;12376.81434778461;12735.108542402313;10137.64518241858;10232.64185753495;10252.128569071712;10425.739356515844;10627.840582391116;10477.9476102619;10499;10580.259381843505;10670.19973502006;10734.785304293715 01:41:08 INFO - PROCESS | 14462 | __end_tp_report 01:41:08 INFO - PROCESS | 14462 | __start_cc_report 01:41:08 INFO - PROCESS | 14462 | _x_x_mozilla_cycle_collect,1092 01:41:08 INFO - PROCESS | 14462 | __end_cc_report 01:41:08 INFO - PROCESS | 14462 | __startTimestamp1483954868136__endTimestamp 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | ------- Summary: start ------- 01:41:08 INFO - PROCESS | 14462 | Number of tests: 6 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | [#0] dojo.html Cycles:165 Average:5611.97 Median:5793.65 stddev:622.76 (10.7%) stddev-sans-first:596.17 01:41:08 INFO - PROCESS | 14462 | Values: 3237.8 3271.2 3272.1 3295.8 3303.9 5599.7 5707.3 5724.3 5729.9 5732.1 5711.4 5766.5 5769.5 5777.4 5778.1 5209.2 5225.5 5232.7 5249.3 5299.7 5005.8 5307.4 5307.6 5319.0 5344.9 5013.5 5045.7 5070.9 5085.9 5114.2 5140.0 5182.7 5191.5 5252.2 5268.6 4929.1 5085.3 5169.4 5197.8 5198.3 5433.7 5543.1 5543.5 5565.7 5595.0 5997.2 5998.3 6085.6 6116.0 6121.4 5793.7 6153.4 6163.2 6173.8 6177.0 5473.3 5525.1 5555.4 5570.7 5609.5 6109.5 6112.4 6117.5 6122.7 6134.2 5742.5 5788.2 5870.4 5872.0 5890.6 5960.9 6043.0 6051.6 6052.9 6053.5 6007.7 6017.5 6018.5 6020.0 6060.3 5970.9 6018.3 6028.1 6031.4 6034.9 4521.2 4521.3 4644.0 4644.8 4679.1 4158.8 4173.5 4185.1 4215.7 4232.6 5733.4 5738.6 5739.6 5744.7 5745.1 5863.3 5905.2 5933.4 5980.4 6066.8 5659.7 5677.7 5683.9 5685.2 5708.7 5236.5 5255.4 5255.9 5257.3 5286.6 5961.7 6014.7 6083.2 6103.4 6127.4 6049.8 6058.1 6064.2 6066.4 6090.3 6174.6 6193.0 6207.5 6212.7 6223.3 5798.4 5842.8 5915.4 5980.2 6012.9 6003.8 6144.9 6150.6 6154.5 6164.0 5946.8 5957.5 6012.0 6022.4 6025.6 5634.4 5672.3 5987.3 5994.0 5998.6 5824.9 5867.1 5871.9 5970.0 5985.4 5995.5 6002.6 6014.5 6015.9 6017.0 5646.7 5698.3 5705.1 5859.8 5870.4 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | [#1] ext.html Cycles:180 Average:60111.11 Median:39117.70 stddev:117344.64 (300.0%) stddev-sans-first:117588.70 01:41:08 INFO - PROCESS | 14462 | Values: 579.6 619.8 630.5 658.4 660.9 34388.1 40643.0 40927.4 41168.6 41208.0 46563.3 46995.0 47070.8 47076.3 47111.3 8373.6 8739.3 8901.0 8904.2 8910.5 8371.0 8677.0 8685.1 10594.0 10849.3 10989.5 11043.1 11043.4 11052.1 11057.0 10857.2 10915.6 10922.7 10939.5 10942.5 10737.7 10781.7 10794.9 10801.4 10804.6 43865.6 44256.8 44315.8 44402.3 44403.3 3657.8 3791.1 3814.0 4025.4 4426.2 32672.8 33038.5 33487.0 33778.8 34561.8 4447.6 4491.8 4501.4 4579.5 4698.2 336590.0 338812.0 339919.0 341159.0 342056.0 38047.4 60696.7 61338.0 61386.7 61387.7 38898.0 40952.8 41172.2 41268.4 41280.8 15003.2 15016.6 15091.2 15137.7 15151.1 10761.2 12943.1 13074.4 13206.5 13208.1 8890.2 9194.5 9431.6 9476.8 9593.6 3585.7 3599.6 3600.7 3623.4 3635.3 1028.2 1037.4 1051.0 1111.4 1218.0 33601.2 33735.5 34655.5 34660.6 34875.1 1126.9 1135.3 1192.1 1261.9 1268.7 17128.2 17156.2 17178.7 17312.2 17366.4 493768.0 498730.0 499200.0 499607.0 500510.0 58355.4 58851.4 58857.0 58868.0 58908.1 1323.1 1370.2 1447.9 1462.8 1479.8 30475.7 33477.5 34444.7 34566.0 34665.0 51891.7 58333.7 60075.7 60104.7 65506.0 472076.0 472171.0 475111.0 475158.0 477708.0 31035.0 32414.2 32555.8 32855.7 33100.3 50991.0 50992.0 51031.7 51074.7 51298.7 42269.6 42441.0 42729.0 43629.0 43885.0 41308.8 41443.8 42295.6 43670.0 45498.5 44257.3 44410.1 44588.6 44649.8 44764.3 36728.6 38674.8 38880.8 39337.4 39668.4 29606.6 29802.9 29901.3 30044.5 30166.4 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | [#2] jquery.html Cycles:180 Average:27973.39 Median:27347.32 stddev:69708.09 (254.9%) stddev-sans-first:69872.87 01:41:08 INFO - PROCESS | 14462 | Values: 392.5 424.5 429.4 436.7 438.7 15916.9 18873.4 20328.5 20586.0 20701.6 20201.2 20428.6 20492.4 20625.2 20668.6 5715.1 5813.8 5941.9 5943.6 5946.0 5760.6 5933.5 5952.0 5956.4 5961.2 5754.6 5905.8 5912.1 5924.3 5927.7 5899.6 6064.2 6081.9 6083.9 6085.0 5925.3 5927.1 6728.9 7153.5 7207.5 25418.7 25603.9 27174.5 27252.2 27442.5 2547.9 2688.1 2746.2 2890.4 3272.4 15768.2 16266.3 16298.2 16587.2 17003.7 2131.8 2232.8 2253.1 2266.6 2279.8 99435.0 102484.0 102982.5 104442.0 104616.5 14744.9 18001.4 18637.9 18804.6 18980.4 27789.9 28535.4 28576.6 28590.0 28612.6 9970.5 10334.3 10345.3 10413.5 10532.9 8588.9 8610.4 8680.3 8854.5 8854.6 9088.9 9193.4 9337.5 9360.4 9377.5 3282.8 3298.7 3589.6 3634.0 3634.4 967.5 970.6 1000.3 1010.7 1015.8 19626.5 19807.9 19825.2 19998.2 20007.6 1000.5 1004.0 1015.8 1025.3 1038.7 10417.7 11074.4 11096.9 11159.4 11171.7 362214.0 365699.0 368270.0 492352.0 493614.0 57465.7 58969.0 59300.0 59359.4 83944.0 1060.3 1063.0 1073.3 1100.4 1109.4 17385.7 17730.4 17765.2 17953.1 18306.5 31095.8 33131.7 41142.8 42843.0 44028.6 55420.0 57633.8 59268.4 60050.7 60723.1 7841.8 8367.8 8553.2 8614.8 9017.1 10363.7 13066.5 13156.1 13592.7 14012.6 11918.6 11934.9 11968.2 12136.6 12227.0 11752.6 11875.8 11996.1 12065.0 12434.9 12131.3 12179.0 12274.4 12601.2 12897.0 9108.8 9120.0 9213.3 9405.6 9491.2 8932.9 11890.3 12030.4 12354.4 12586.5 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | [#3] mootools.html Cycles:180 Average:5589.37 Median:5176.94 stddev:3036.27 (58.6%) stddev-sans-first:3028.86 01:41:08 INFO - PROCESS | 14462 | Values: 1451.1 1509.0 1604.8 1723.4 1734.5 7967.4 8477.5 8480.3 8488.2 8489.0 7426.4 7635.6 8008.7 8150.0 8172.2 2416.2 2420.2 2435.5 2436.9 2438.2 2411.9 2449.0 2498.3 2499.0 2501.2 2070.9 2139.4 2139.6 2150.2 2365.3 2438.9 2485.4 2493.6 2495.3 2498.0 2406.8 2435.9 2445.0 2446.6 2447.4 8284.5 8409.6 8481.0 8481.4 8493.7 5224.7 5360.2 5362.1 5363.4 5364.6 3237.9 3425.5 3466.9 3479.7 3497.4 1024.5 1109.6 1115.7 2046.7 2161.2 11551.9 11597.2 11646.9 11675.5 11680.5 4380.8 4543.1 4618.0 4620.8 4704.0 9076.0 9077.9 9080.8 9090.8 9098.4 5352.1 5355.6 5357.8 5363.8 5366.9 4833.9 4987.2 5024.3 5027.2 5048.7 3660.4 3688.8 3755.6 3785.3 3786.8 1166.7 1179.4 1180.7 1183.5 1196.0 961.1 995.0 1002.5 1002.7 1004.1 5836.8 5843.4 5865.7 5885.7 6036.0 495.2 503.9 513.4 515.2 519.3 4083.6 4172.2 4197.8 4259.9 4289.2 10090.4 10466.3 10474.1 10486.5 10489.5 10410.7 10412.5 10425.2 10426.8 10469.4 7781.5 7831.0 7883.5 7959.8 7982.8 5674.7 5746.4 5857.0 5875.8 5882.5 9139.9 9216.0 9315.3 9327.4 9342.9 9544.2 9643.8 9644.5 9656.7 9656.8 6946.2 7046.9 7054.5 7055.7 7058.6 7767.8 7906.3 7952.9 8079.6 8162.7 7302.3 7336.2 7372.7 7392.7 7636.0 7202.4 7340.6 7370.2 7399.0 7420.7 6847.3 6873.0 6957.6 6962.0 6983.9 5148.9 5176.4 5262.7 5263.8 5320.6 5114.9 5172.0 5177.5 5205.3 5304.4 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | [#4] prototype.html Cycles:180 Average:4760.38 Median:5365.15 stddev:1357.88 (25.3%) stddev-sans-first:1320.26 01:41:08 INFO - PROCESS | 14462 | Values: 325.1 351.0 356.6 357.3 364.9 5249.2 5302.8 5349.4 5441.8 5461.3 5336.6 5360.2 5370.1 5420.9 5429.3 4285.8 4292.5 4302.9 4317.6 4322.7 4101.3 4188.7 4248.4 4311.2 4331.7 4267.5 4278.5 4285.9 4287.3 4292.8 4275.1 4276.1 4279.3 4283.5 4288.9 3763.0 3826.0 3860.5 3861.6 3863.3 5227.7 5255.7 5261.0 5261.6 5291.5 4897.5 4897.7 4898.0 4908.0 4909.9 5536.8 5568.9 5627.6 5649.9 5669.7 4188.8 4188.8 4190.5 4199.8 4203.5 5858.7 5860.0 5860.7 5874.3 5887.5 4199.9 4273.0 4289.7 4300.5 4317.2 4331.8 4334.5 4352.8 4360.9 4374.2 4592.2 4733.5 4744.0 4746.6 4767.0 5537.7 5665.8 5688.7 5695.3 5705.4 1408.7 1463.0 1463.3 1467.2 1474.4 1023.9 1031.5 1041.2 1043.4 1043.9 5274.5 5281.7 5286.6 5347.9 5353.9 5642.0 5645.4 5653.8 5661.2 5671.0 5235.7 5507.7 5520.3 5535.5 5539.2 2978.5 2997.0 2998.9 3001.7 3013.9 5607.9 5705.5 5710.9 5748.7 5748.9 5742.9 5754.4 5761.3 5770.6 5789.2 5716.2 5725.1 5725.7 5741.7 5744.5 5379.9 5595.9 5600.3 5616.4 5626.9 5553.6 5582.8 5592.6 5610.9 5611.6 5595.4 5708.0 5710.9 5718.3 5932.3 4249.6 4280.7 4292.4 4309.5 4311.6 5634.7 5724.3 5816.2 5894.8 5924.2 5734.7 5741.3 5742.3 5754.6 5755.1 5599.2 5705.7 5707.3 5742.9 5752.0 5618.6 5665.9 5685.9 5692.5 5711.4 5652.4 5685.7 5740.7 5740.8 5749.8 5423.7 5585.2 5601.4 5625.7 5626.5 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - PROCESS | 14462 | [#5] yui.html Cycles:180 Average:18265.14 Median:4843.10 stddev:24388.27 (503.6%) stddev-sans-first:24421.48 01:41:08 INFO - PROCESS | 14462 | Values: 811.5 829.5 854.2 854.4 877.5 14059.2 14999.7 15283.4 15291.7 15316.1 14661.0 14812.6 14949.8 14953.2 15003.8 732.1 856.2 868.8 869.4 869.5 726.3 735.5 735.7 849.1 861.8 886.0 903.2 903.3 903.9 904.2 897.4 897.5 898.3 898.7 898.8 559.2 567.6 570.2 668.9 671.6 12424.1 13886.2 14220.8 14260.1 14903.3 15070.4 15216.7 15682.7 15762.2 15797.1 11885.2 11954.2 11988.0 12099.3 12189.6 3882.5 3893.4 3937.8 3946.8 3994.5 64903.7 65956.7 66271.7 66391.7 68289.0 10712.7 10751.7 10852.6 10925.1 11228.3 22121.4 22158.7 22172.1 22194.3 22361.6 8319.3 8344.6 8498.3 8630.0 8669.6 4393.0 4611.7 4657.7 4767.3 4793.2 3485.6 3602.5 3602.8 3604.8 3613.3 581.5 594.4 595.5 609.6 650.7 738.8 756.2 757.6 766.8 778.5 9248.3 9374.9 9474.3 10131.2 10149.6 631.4 666.8 735.2 739.3 751.8 4591.2 4637.6 4734.5 4822.3 4863.9 88261.6 93467.5 94230.5 94243.5 95400.5 49539.0 64934.0 78975.6 79515.2 79774.6 67586.3 68510.7 68947.0 69182.0 69428.0 8780.0 8894.5 8989.7 9095.3 9127.4 49899.0 50732.0 50746.0 51192.7 52585.7 64248.0 68711.7 70137.6 70486.6 73188.6 11539.9 11719.5 11730.1 11812.0 11952.0 12964.5 12968.5 13091.1 13262.3 13961.9 11744.5 11777.2 11878.8 12204.1 12573.4 12381.3 12760.1 12790.6 13294.4 13308.6 11697.6 11806.4 11993.0 12376.8 12735.1 10137.6 10232.6 10252.1 10425.7 10627.8 10477.9 10499.0 10580.3 10670.2 10734.8 01:41:08 INFO - PROCESS | 14462 | -------- Summary: end -------- 01:41:08 INFO - PROCESS | 14462 | 01:41:08 INFO - TEST-INFO | 14462: exit 0 01:41:08 INFO - TEST-OK | dromaeo_css | took 1114675ms 01:41:08 INFO - TEST-START | kraken 01:41:08 INFO - operating with platform_type : linux_ 01:41:08 INFO - Initialising browser for kraken test... 01:41:08 INFO - TEST-INFO | started process 14779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgS_5zd/profile http://localhost:60114/getInfo.html) 01:41:12 INFO - PROCESS | 14779 | __metrics Screen width/height:1600/1200 01:41:12 INFO - PROCESS | 14779 | colorDepth:24 01:41:12 INFO - PROCESS | 14779 | Browser inner width/height: 1024/697 01:41:12 INFO - PROCESS | 14779 | __metrics 01:41:12 INFO - PROCESS | 14779 | 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" 01:41:12 INFO - PROCESS | 14779 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:41:13 INFO - PROCESS | 14779 | console.error: PushService: 01:41:13 INFO - PROCESS | 14779 | stateChangeProcessEnqueue: Error transitioning state 01:41:13 INFO - PROCESS | 14779 | UnknownError 01:41:13 INFO - TEST-INFO | 14779: exit 0 01:41:13 INFO - Browser initialized. 01:41:13 INFO - Running cycle 1/1 for kraken test... 01:41:13 INFO - TEST-INFO | started process 14872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgS_5zd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:25 INFO - PROCESS | 14872 | RSS: Main: 145301504 01:41:25 INFO - PROCESS | 14872 | 01:41:28 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60114/tests/kraken/driver.html?testName=audio-beat-detection) 01:41:29 INFO - PROCESS | 14872 | RSS: Main: 185794560 01:41:29 INFO - PROCESS | 14872 | 01:41:31 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60114/tests/kraken/driver.html?testName=audio-dft) 01:41:32 INFO - PROCESS | 14872 | RSS: Main: 175566848 01:41:32 INFO - PROCESS | 14872 | 01:41:34 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60114/tests/kraken/driver.html?testName=audio-fft) 01:41:35 INFO - PROCESS | 14872 | RSS: Main: 266821632 01:41:35 INFO - PROCESS | 14872 | 01:41:37 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60114/tests/kraken/driver.html?testName=audio-oscillator) 01:41:38 INFO - PROCESS | 14872 | RSS: Main: 173084672 01:41:38 INFO - PROCESS | 14872 | 01:41:40 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:41:40 INFO - PROCESS | 14872 | RSS: Main: 175693824 01:41:40 INFO - PROCESS | 14872 | 01:41:43 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60114/tests/kraken/driver.html?testName=imaging-darkroom) 01:41:44 INFO - PROCESS | 14872 | RSS: Main: 214839296 01:41:44 INFO - PROCESS | 14872 | 01:41:47 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60114/tests/kraken/driver.html?testName=imaging-desaturate) 01:41:48 INFO - PROCESS | 14872 | RSS: Main: 213106688 01:41:48 INFO - PROCESS | 14872 | 01:41:51 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60114/tests/kraken/driver.html?testName=json-parse-financial) 01:41:51 INFO - PROCESS | 14872 | RSS: Main: 212393984 01:41:51 INFO - PROCESS | 14872 | 01:41:53 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:41:53 INFO - PROCESS | 14872 | RSS: Main: 173998080 01:41:53 INFO - PROCESS | 14872 | 01:41:55 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:41:56 INFO - PROCESS | 14872 | RSS: Main: 181600256 01:41:56 INFO - PROCESS | 14872 | 01:41:57 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:41:58 INFO - PROCESS | 14872 | RSS: Main: 189419520 01:41:58 INFO - PROCESS | 14872 | 01:42:01 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:42:01 INFO - PROCESS | 14872 | RSS: Main: 198819840 01:42:01 INFO - PROCESS | 14872 | 01:42:04 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:42:05 INFO - PROCESS | 14872 | RSS: Main: 195223552 01:42:05 INFO - PROCESS | 14872 | 01:42:06 INFO - PROCESS | 14872 | Cycle 1(1): loaded http://localhost:60114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60114/tests/kraken/driver.html?testName=ai-astar) 01:42:07 INFO - PROCESS | 14872 | RSS: Main: 246472704 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | __start_tp_report 01:42:07 INFO - PROCESS | 14872 | _x_x_mozilla_page_load 01:42:07 INFO - PROCESS | 14872 | _x_x_mozilla_page_load_details 01:42:07 INFO - PROCESS | 14872 | |i|pagename|runs| 01:42:07 INFO - PROCESS | 14872 | |0;ai-astar;103;112;119;112;114;112;112;111;110;111 01:42:07 INFO - PROCESS | 14872 | |1;audio-beat-detection;142;116;120;166;125;117;118;118;146;122 01:42:07 INFO - PROCESS | 14872 | |2;audio-dft;162;159;160;160;160;160;161;159;161;161 01:42:07 INFO - PROCESS | 14872 | |3;audio-fft;74;74;75;115;76;76;76;75;98;74 01:42:07 INFO - PROCESS | 14872 | |4;audio-oscillator;82;82;113;82;81;81;97;82;83;117 01:42:07 INFO - PROCESS | 14872 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;116;117 01:42:07 INFO - PROCESS | 14872 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;147;147 01:42:07 INFO - PROCESS | 14872 | |7;imaging-desaturate;86;85;85;85;85;85;84;84;85;84 01:42:07 INFO - PROCESS | 14872 | |8;json-parse-financial;51;50;50;53;50;51;49;52;50;50 01:42:07 INFO - PROCESS | 14872 | |9;json-stringify-tinderbox;57;59;57;58;59;57;58;58;59;58 01:42:07 INFO - PROCESS | 14872 | |10;stanford-crypto-aes;75;76;74;75;80;75;77;76;73;75 01:42:07 INFO - PROCESS | 14872 | |11;stanford-crypto-ccm;122;131;124;136;121;120;133;118;154;139 01:42:07 INFO - PROCESS | 14872 | |12;stanford-crypto-pbkdf2;155;158;155;157;153;154;154;166;156;159 01:42:07 INFO - PROCESS | 14872 | |13;stanford-crypto-sha256-iterative;64;63;65;63;62;64;63;62;64;61 01:42:07 INFO - PROCESS | 14872 | __end_tp_report 01:42:07 INFO - PROCESS | 14872 | __start_cc_report 01:42:07 INFO - PROCESS | 14872 | _x_x_mozilla_cycle_collect,1633 01:42:07 INFO - PROCESS | 14872 | __end_cc_report 01:42:07 INFO - PROCESS | 14872 | __startTimestamp1483954927030__endTimestamp 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | ------- Summary: start ------- 01:42:07 INFO - PROCESS | 14872 | Number of tests: 14 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:2.65 01:42:07 INFO - PROCESS | 14872 | Values: 103.0 112.0 119.0 112.0 114.0 112.0 112.0 111.0 110.0 111.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:123.50 stddev:16.76 (13.6%) stddev-sans-first:17.10 01:42:07 INFO - PROCESS | 14872 | Values: 142.0 116.0 120.0 166.0 125.0 117.0 118.0 118.0 146.0 122.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 01:42:07 INFO - PROCESS | 14872 | Values: 162.0 159.0 160.0 160.0 160.0 160.0 161.0 159.0 161.0 161.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:13.90 (18.4%) stddev-sans-first:14.49 01:42:07 INFO - PROCESS | 14872 | Values: 74.0 74.0 75.0 115.0 76.0 76.0 76.0 75.0 98.0 74.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:14.04 (17.1%) stddev-sans-first:14.59 01:42:07 INFO - PROCESS | 14872 | Values: 82.0 82.0 113.0 82.0 81.0 81.0 97.0 82.0 83.0 117.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:42:07 INFO - PROCESS | 14872 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:42:07 INFO - PROCESS | 14872 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 01:42:07 INFO - PROCESS | 14872 | Values: 86.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:1.17 (2.3%) stddev-sans-first:1.24 01:42:07 INFO - PROCESS | 14872 | Values: 51.0 50.0 50.0 53.0 50.0 51.0 49.0 52.0 50.0 50.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 01:42:07 INFO - PROCESS | 14872 | Values: 57.0 59.0 57.0 58.0 59.0 57.0 58.0 58.0 59.0 58.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:1.90 (2.5%) stddev-sans-first:2.00 01:42:07 INFO - PROCESS | 14872 | Values: 75.0 76.0 74.0 75.0 80.0 75.0 77.0 76.0 73.0 75.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:132.00 stddev:11.19 (8.5%) stddev-sans-first:11.51 01:42:07 INFO - PROCESS | 14872 | Values: 122.0 131.0 124.0 136.0 121.0 120.0 133.0 118.0 154.0 139.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.50 stddev:3.77 (2.4%) stddev-sans-first:3.95 01:42:07 INFO - PROCESS | 14872 | Values: 155.0 158.0 155.0 157.0 153.0 154.0 154.0 166.0 156.0 159.0 01:42:07 INFO - PROCESS | 14872 | 01:42:07 INFO - PROCESS | 14872 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.20 (1.9%) stddev-sans-first:1.22 01:42:07 INFO - PROCESS | 14872 | Values: 64.0 63.0 65.0 63.0 62.0 64.0 63.0 62.0 64.0 61.0 01:42:07 INFO - PROCESS | 14872 | -------- Summary: end -------- 01:42:07 INFO - PROCESS | 14872 | 01:42:08 INFO - TEST-INFO | 14872: exit 0 01:42:08 INFO - TEST-OK | kraken | took 59133ms 01:42:08 INFO - SUITE-END | took 1173s 01:42:08 INFO - Completed test suite (00:19:33) 01:42:08 INFO - javascript benchmark 01:42:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.7733558650893, 3271.2149084219777, 3272.083816531371, 3295.785773924696, 3303.9008829735117, 5599.692016939067, 5707.258056452661, 5724.2558467399285, 5729.856753581163, 5732.111522713986, 5711.400302968181, 5766.509846663028, 5769.538436925046, 5777.393373695754, 5778.075507918734, 5209.192575150839, 5225.503577160163, 5232.659877107976, 5249.343832020997, 5299.655522391052, 5005.849824505271, 5307.363116426034, 5307.628466007381, 5319.015982043315, 5344.946550534483, 5013.523715247045, 5045.672031317952, 5070.898582028357, 5085.872853178663, 5114.156164232897, 5140.049090918192, 5182.7408629568745, 5191.480851914816, 5252.212168174766, 5268.631195816294, 4929.137400954819, 5085.338905942203, 5169.4313625501545, 5197.766100525486, 5198.2722418861385, 5433.673979561239, 5543.057680194336, 5543.473370029841, 5565.721713914288, 5595.048841696921, 5997.190379298782, 5998.340182579913, 6085.574009819315, 6115.9694201529155, 6121.387861213888, 5793.65238085712, 6153.446189842935, 6163.19878415803, 6173.845653858644, 6176.980798168297, 5473.343198816127, 5525.143602741541, 5555.444455554412, 5570.6657600544095, 5609.467100625434, 6109.480694140959, 6112.358202388685, 6117.480014198754, 6122.663253521099, 6134.2332208473945, 5742.454466825645, 5788.247527821356, 5870.354261031283, 5872.031114866085, 5890.617109887844, 5960.910586341209, 6043.033114701714, 6051.606645568024, 6052.878942421127, 6053.4551890330085, 6007.729652165663, 6017.548683848641, 6018.548608854266, 6020.0, 6060.272767267956, 5970.940290597038, 6018.337982821886, 6028.125921741323, 6031.396860313934, 6034.9396506035255, 4521.163584736834, 4521.344405061248, 4644.0, 4644.790984405709, 4679.087577922272, 4158.750474971512, 4173.478315210598, 4185.100203456272, 4215.662746980234, 4232.597903199191, 5733.397993210736, 5738.598298119092, 5739.598228124075, 5744.684042377709, 5745.052066409079, 5863.2670916135485, 5905.232319798399, 5933.376995415506, 5980.372060933626, 6066.848328791727, 5659.745311460994, 5677.659340439504, 5683.914741278884, 5685.1756495307945, 5708.743106560215, 5236.502532259429, 5255.421903590602, 5255.947440525546, 5257.342832145981, 5286.550643195372, 5961.731722072431, 6014.72933717975, 6083.239595050619, 6103.42017508336, 6127.448529632355, 6049.818505444844, 6058.12157237207, 6064.241969753781, 6066.393360663898, 6090.2996155440915, 6174.6424957758645, 6193.0, 6207.534434917489, 6212.658303793335, 6223.315435302023, 5798.420157984337, 5842.766289348378, 5915.438033386821, 5980.222571065734, 6012.939870601238, 6003.759849606142, 6144.863200307957, 6150.569460137926, 6154.476869466145, 6164.044573091178, 5946.791862284799, 5957.523398128226, 6012.0, 6022.427869352405, 6025.6083354581815, 5634.408387119457, 5672.319321681424, 5987.341392446914, 5993.9700301498215, 5998.640081595118, 5824.94175058244, 5867.149263356875, 5871.853203669943, 5970.044792833126, 5985.431384018511, 5995.46040856325, 6002.639841609517, 6014.518838492998, 6015.909761353496, 6016.977113890562, 5646.745896434588, 5698.2592263005545, 5705.115707065412, 5859.824205273849, 5870.442307980735], "value": 5570.849311966361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.6174524813624, 619.8047615001274, 630.4704048599177, 658.3975662269024, 660.857915548157, 34388.1402964926, 40643.0, 40927.38608920869, 41168.588314116925, 41208.0, 46563.30155047669, 46994.99999999991, 47070.76464617681, 47076.29385559211, 47111.29333060007, 8373.62318695657, 8739.300855931526, 8901.0, 8904.243139333132, 8910.465372077664, 8370.958145209266, 8677.045524992245, 8685.0880657531, 10594.046535811776, 10849.349039057683, 10989.450527473635, 11043.116550675926, 11043.447827608628, 11052.115830733563, 11057.0, 10857.23999320048, 10915.563377464892, 10922.726931826688, 10939.45302734868, 10942.45287735614, 10737.731556711067, 10781.730456738644, 10794.892051079467, 10801.40592267425, 10804.621838235624, 43865.561344386464, 44256.778716106535, 44315.77842110769, 44402.333964990554, 44403.333949990774, 3657.8353974070965, 3791.109089363997, 3814.0, 4025.376066709665, 4426.247537918562, 32672.836635816668, 33038.50442243368, 33487.0, 33778.831105844314, 34561.82719086413, 4447.5552444755585, 4491.820327186909, 4501.392312037866, 4579.519150489217, 4698.201305778026, 336590.0, 338812.0, 339919.0, 341159.0, 342056.0, 38047.42928856069, 60696.696516518015, 61338.0, 61386.69306653438, 61387.69306153441, 38898.0, 40952.79523602423, 41172.1765564687, 41268.38097428541, 41280.79359603183, 15003.249837508081, 15016.624584385478, 15091.24543772807, 15137.697246055237, 15151.090934543963, 10761.246712730033, 12943.093983421259, 13074.411651475517, 13206.47174113044, 13208.141470804367, 8890.244329231959, 9194.494302813277, 9431.622735090657, 9476.763080922894, 9593.568289426992, 3585.731070169748, 3599.6040435552068, 3600.747947643692, 3623.4202527595457, 3635.2729454109285, 1028.1774580335702, 1037.4242295525905, 1050.9632162874263, 1111.366521082991, 1217.9756404871853, 33601.15997100092, 33735.493967590504, 34655.480167797505, 34660.6135754567, 34875.128121797155, 1126.9098472122212, 1135.28477059452, 1192.0820967854704, 1261.8548866880426, 1268.7145392286845, 17128.229229684694, 17156.22796974139, 17178.74231886523, 17312.22095005728, 17366.39217627377, 493768.0, 498730.0, 499200.0, 499607.0, 500510.0, 58355.416445835, 58851.41148588459, 58857.0, 58868.0, 58908.11637825436, 1323.0606269548537, 1370.2463644995212, 1447.9420823166956, 1462.7586448236134, 1479.7928290039404, 30475.695243047285, 33477.49783753197, 34444.65555344414, 34566.0, 34665.0, 51891.740541297055, 58333.708331458074, 60075.69962150161, 60104.69947650409, 65506.0, 472076.0, 472171.0, 475111.0, 475158.0, 477708.0, 31034.98272612363, 32414.189645259055, 32555.837220813744, 32855.67144328622, 33100.33799323952, 50991.0, 50992.0, 51031.744841275555, 51074.74462627663, 51298.74350628223, 42269.577304227794, 42441.0, 42729.0, 43629.0, 43885.0, 41308.79345603253, 41443.7927810359, 42295.57704422916, 43670.0, 45498.54501454943, 44257.33613995857, 44410.11179776322, 44588.55411445844, 44649.776751116035, 44764.32853507135, 36728.63271367252, 38674.80662596669, 38880.80559597184, 39337.40993885037, 39668.40497392484, 29606.55590166106, 29802.85098574493, 29901.252468688457, 30044.549331759605, 30166.396672066876], "value": 20082.056665771903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.46232661254083, 424.5267197884075, 429.4352925902438, 436.66595054783085, 438.65565531058127, 15916.92041539792, 18873.433796986094, 20328.49178770528, 20586.0, 20701.585968280644, 20201.19195232189, 20428.59142817143, 20492.385228443134, 20625.1749930003, 20668.586628267425, 5715.114157305614, 5813.82558523245, 5941.910871336933, 5943.55423343251, 5945.970270148643, 5760.56795740319, 5933.495652869511, 5951.970240148815, 5956.404359564052, 5961.225040744697, 5754.597178197528, 5905.793297234598, 5912.142739302799, 5924.348321684612, 5927.703614819264, 5899.616524925866, 6064.241969753781, 6081.908771368433, 6083.874483220597, 6084.99597566401, 5925.34821169671, 5927.051671732545, 6728.93271067288, 7153.4620056687545, 7207.45944054198, 25418.74581254201, 25603.871980640164, 27174.45651086987, 27252.182434526996, 27442.451150976867, 2547.8598677072755, 2688.1263589333544, 2746.231055304518, 2890.421915616885, 3272.361889431562, 15768.211589420484, 16266.349346026145, 16298.185090745415, 16587.170641467877, 17003.74494382585, 2131.82945364372, 2232.810211132056, 2253.053717438663, 2266.5806825737127, 2279.806216471602, 99435.0, 102484.0, 102982.48508757408, 104441.99999999924, 104616.47691761568, 14744.894132940073, 18001.376721520857, 18637.90681046586, 18804.623907521775, 18980.43058708241, 27789.861050694617, 28535.429291414057, 28576.571351429746, 28590.0, 28612.57081143743, 9970.501474926225, 10334.276600638033, 10345.275830691779, 10413.479326033668, 10532.894671053346, 8588.8711669325, 8610.440321379216, 8680.30557555394, 8854.513001784835, 8854.64581416749, 9088.863667045, 9193.402428842104, 9337.486438245825, 9360.4383736976, 9377.484238366818, 3282.8030318180986, 3298.736101111905, 3589.6410358964417, 3633.982484904231, 3634.3821550336506, 967.4920666650065, 970.5583959298502, 1000.3247807729754, 1010.7018429563296, 1015.8120747661559, 19626.509337266398, 19807.900960495106, 19825.20699172017, 19998.20007199696, 20007.59984800325, 1000.4997501249376, 1003.9899601004042, 1015.8476228565775, 1025.2669341420772, 1038.7143535527791, 10417.739556511147, 11074.39090850011, 11096.944515277371, 11159.442027898735, 11171.72070698239, 362214.0, 365699.0, 368270.0, 492352.0, 493614.0, 57465.71267143721, 58969.0, 59300.0, 59359.40640593539, 83944.0, 1060.2949038889053, 1062.9787404252027, 1073.3398959639765, 1100.4497751124438, 1109.417555783204, 17385.739213911547, 17730.379436719653, 17765.200565974304, 17953.10234488244, 18306.450806475827, 31095.844520777253, 33131.668683312855, 41142.79428602838, 42843.0, 44028.559714403724, 55420.0, 57633.84732305414, 59268.40731592629, 60050.699746500984, 60723.089153661844, 7841.764747057598, 8367.790805229917, 8553.230209281195, 8614.82770344602, 9017.053209412918, 10363.689089327332, 13066.477340906638, 13156.144850584682, 13592.66018349549, 14012.579622611338, 11918.582849600223, 11934.880651193724, 11968.222065565711, 12136.635900922987, 12227.0, 11752.647420577396, 11875.821862671894, 11996.100292477924, 12065.0, 12434.937825310815, 12131.332776697014, 12179.0, 12274.386280686109, 12601.18092323996, 12897.0, 9108.772280693036, 9120.02227791692, 9213.262938965001, 9405.576749046173, 9491.240700744062, 8932.910670893209, 11890.28658280506, 12030.398480075786, 12354.382280886099, 12586.496540138658], "value": 10314.052997708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.0785651111544, 1508.9849101508985, 1604.8314926932671, 1723.4140392266627, 1734.523006173303, 7967.40244481664, 8477.533735644538, 8480.279176270009, 8488.23605875471, 8489.0, 7426.443016773736, 7635.580043097628, 8008.67965281388, 8150.021997360325, 8172.1827817218245, 2416.1664225842055, 2420.20133355993, 2435.476372579895, 2436.8903399347073, 2438.1588352018525, 2411.927642170729, 2448.9877550612223, 2498.3254521279246, 2498.9875050624723, 2501.162110692911, 2070.8550401471903, 2139.4330502416874, 2139.6148693235214, 2150.2151714624206, 2365.314058922919, 2438.9146379876706, 2485.3662316109367, 2493.6010238361773, 2495.3137887081016, 2497.9750202497926, 2406.783389494954, 2435.8538487690794, 2444.9511009779703, 2446.584080706284, 2447.3514518652573, 8284.544350060743, 8409.621567029499, 8480.982282126122, 8481.363897707635, 8493.702720404755, 5224.712640804754, 5360.195970604402, 5362.142057270857, 5363.410024897258, 5364.597655175839, 3237.87048518059, 3425.486177073434, 3466.9306613867834, 3479.6694314040124, 3497.3704733148024, 1024.4928760263642, 1109.572814466428, 1115.7433790228292, 2046.7339245898088, 2161.243564752324, 11551.884481155164, 11597.188196826226, 11646.883531164665, 11675.532978680927, 11680.474378652982, 4380.78096095194, 4543.091381723669, 4617.976910115428, 4620.792064357112, 4704.0356726870905, 9075.954620226988, 9077.909220907839, 9080.772980675536, 9090.772730681785, 9098.363114582047, 5352.063388906926, 5355.625106242604, 5357.785688572491, 5363.846772943836, 5366.91949620756, 4833.9033219335415, 4987.202047672355, 5024.271480635288, 5027.195648696191, 5048.697078175322, 3660.396034654252, 3688.7602305850032, 3755.6244375562223, 3785.299719551892, 3786.848526058982, 1166.7083229192701, 1179.4279774309452, 1180.7461395799944, 1183.4792691215837, 1196.0491409329604, 961.1205746741792, 995.0447570332561, 1002.4937406609761, 1002.7493126718321, 1004.1314263162312, 5836.761937019967, 5843.415658434207, 5865.677387743715, 5885.705714714247, 6036.0, 495.23238979581504, 503.87151276424277, 513.3916309173641, 515.1500024958773, 519.2600544224465, 4083.5508094109623, 4172.186423647359, 4197.790110494524, 4259.936100958488, 4289.1850548395705, 10090.44502552352, 10466.319689220329, 10474.057334839901, 10486.475676216158, 10489.527971241312, 10410.739731506774, 10412.479376031168, 10425.165986721044, 10426.843597346045, 10469.37183768961, 7781.45529812919, 7831.0, 7883.526988380716, 7959.761207163794, 7982.840343193104, 5674.74463649145, 5746.367899531132, 5857.0, 5875.764969401176, 5882.5293976480925, 9139.862902056608, 9216.032316606928, 9315.301352398461, 9327.393719408217, 9342.906570934203, 9544.188743956563, 9643.807123857623, 9644.517774111126, 9656.71029869105, 9656.806863862825, 6946.16646002483, 7046.929530704832, 7054.541454805421, 7055.717771289091, 7058.611776352144, 7767.766966990999, 7906.288434040964, 7952.880706789519, 8079.636416361161, 8162.7143049992965, 7302.306280903305, 7336.156342020736, 7372.668229929774, 7392.667329970057, 7636.0, 7202.351788339075, 7340.596267205355, 7370.226126256666, 7398.96300518494, 7420.6660700269695, 6847.315268473113, 6872.965635171792, 6957.617331046638, 6962.0, 6983.895241571279, 5148.897022059613, 5176.4047134580005, 5262.710550919583, 5263.763130659206, 5320.627556071038, 5114.923276150935, 5171.974140129275, 5177.4822517749435, 5205.297284866495, 5304.416514183359], "value": 4508.16677034437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.1108219020979, 350.95086687863704, 356.63444968906873, 357.292560729755, 364.8923567547573, 5249.186376111699, 5302.761375738091, 5349.358077030762, 5441.83674489766, 5461.290032295796, 5336.557920141507, 5360.249565060885, 5370.060239458089, 5420.915816836628, 5429.348478182624, 4285.785710714467, 4292.549282325358, 4302.913941721179, 4317.611414972652, 4322.675799315064, 4101.2617728808955, 4188.685848561355, 4248.447701798762, 4311.180875633635, 4331.675124365669, 4267.509236437802, 4278.486581610196, 4285.892852678692, 4287.31402975524, 4292.806823692941, 4275.144971005796, 4276.123394704078, 4279.33670281107, 4283.50077472882, 4288.869125538375, 3763.0, 3826.005238637946, 3860.478835357219, 3861.555921069085, 3863.323918314312, 5227.712475813829, 5255.710935898524, 5260.973695131538, 5261.579073674096, 5291.497307755757, 4897.51024897511, 4897.681650692693, 4897.951020489785, 4908.0, 4909.852704418838, 5536.833894983157, 5568.916466252969, 5627.634203776742, 5649.943500564983, 5669.688167150805, 4188.790560471964, 4188.832446702128, 4190.51809041961, 4199.832006719727, 4203.453551038376, 5858.736356863908, 5859.9783074839115, 5860.714321414652, 5874.265716785402, 5887.528997680175, 4199.91600167995, 4273.0, 4289.699721019499, 4300.483941926988, 4317.222899878052, 4331.80506877185, 4334.523202447728, 4352.847650332224, 4360.869173924787, 4374.190774706626, 4592.15045216636, 4733.5266473352385, 4744.0, 4746.572808447257, 4767.0, 5537.667739935617, 5665.773369065274, 5688.728980836036, 5695.259616249861, 5705.372409035002, 1408.7393832141086, 1462.9612974787808, 1463.3341829467568, 1467.2150399536197, 1474.3954978458994, 1023.9299931571526, 1031.4584842957358, 1041.2450973044633, 1043.4417586591137, 1043.9478026098664, 5274.498922602346, 5281.705982034349, 5286.5506431952945, 5347.86630334237, 5353.866153346197, 5642.0, 5645.407232240637, 5653.830385088454, 5661.235733176051, 5671.0, 5235.701508049904, 5507.697076660822, 5520.282363292747, 5535.501804837584, 5539.1997600779905, 2978.5234362501897, 2996.955045674317, 2998.9100326990224, 3001.7392695068124, 3013.9397212055637, 5607.906228453252, 5705.486506214377, 5710.885782284414, 5748.683822389725, 5748.872917020729, 5742.856428589235, 5754.367019627837, 5761.279840019997, 5770.6249093808765, 5789.160571717078, 5716.228309178291, 5725.112607545837, 5725.742341594555, 5741.74162162712, 5744.540436765049, 5379.946200537945, 5595.8880822384135, 5600.327960644749, 5616.38219795814, 5626.943730562642, 5553.6390134641115, 5582.8325150245555, 5592.636478629039, 5610.943890561042, 5611.607187496836, 5595.356533998643, 5707.971460142673, 5710.857828434247, 5718.313802343745, 5932.2584676915385, 4249.55379685141, 4280.72175308604, 4292.3561465780385, 4309.525952145199, 4311.633511151462, 5634.74643641029, 5724.255846740064, 5816.208220054482, 5894.793682221101, 5924.200232968494, 5734.7061175530125, 5741.339745929272, 5742.253507044057, 5754.5684073695475, 5755.1367294906095, 5599.160125981135, 5705.714714264187, 5707.315122185364, 5742.942570574241, 5752.0, 5618.578606604439, 5665.943340566541, 5685.943140568541, 5692.459216374438, 5711.428857114255, 5652.4064973178865, 5685.715714214355, 5740.650947027361, 5740.823131257998, 5749.8275051748515, 5423.674579525241, 5585.162225666182, 5601.383847776823, 5625.662460252398, 5626.465485778845], "value": 4333.731708504698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.5212024905304, 829.5313148071343, 854.2013217641505, 854.4360721923531, 877.5261358866212, 14059.156450612958, 14999.700005999874, 15283.388664453436, 15291.694166116671, 15316.081035137886, 14661.0, 14812.555623331291, 14949.775753363681, 14953.177575233358, 15003.849961500382, 732.0739264829967, 856.2422256303186, 868.7784614923186, 869.387082107113, 869.5130726792985, 726.3100054947794, 735.4667865797308, 735.6615956659916, 849.142366210126, 861.7802460372596, 886.0430734806394, 903.223228023899, 903.2728653434016, 903.941243819153, 904.2178515584005, 897.3539051882634, 897.5287973813735, 898.348697194532, 898.7079199260202, 898.8067565473422, 559.2226804741372, 567.6452217364148, 570.1561688700746, 668.906353110565, 671.6071098407438, 12424.130310878241, 13886.166829990132, 14220.786688199685, 14260.14439133645, 14903.254837258093, 15070.397184112622, 15216.695666086727, 15682.68634627301, 15762.211889405484, 15797.131157786318, 11885.168038237327, 11954.163208575403, 11988.0, 12099.274043557414, 12189.634310970685, 3882.514685664292, 3893.3575959966856, 3937.822797974098, 3946.8026598669953, 3994.520657521116, 64903.67548162229, 65956.67021664909, 66271.66864165697, 66391.66804165948, 68289.0, 10712.73218169552, 10751.677449676523, 10852.620158294421, 10925.125989920787, 11228.326300422, 22121.44696382571, 22158.667619985714, 22172.113115475524, 22194.334169974925, 22361.55276894453, 8319.251267385844, 8344.62449189788, 8498.320134389234, 8630.0, 8669.566521674018, 4393.033532622818, 4611.746353950565, 4657.69724967876, 4767.332573439652, 4793.209120495079, 3485.5643044619424, 3602.45963105531, 3602.819859007039, 3604.8377822998027, 3613.259281847215, 581.4650521520211, 594.4145017158096, 595.5384576952896, 609.6281268426256, 650.7006776882592, 738.7746737245192, 756.239978821281, 757.5984728094119, 766.8006318357267, 778.4550814429922, 9248.26013918885, 9374.85937710935, 9474.289428292906, 10131.189504839595, 10149.594016239416, 631.400169838646, 666.849958759285, 735.1876176824532, 739.3235189801271, 751.7819832248587, 4591.242444996605, 4637.582617564435, 4734.502877197913, 4822.324874517571, 4863.878403039882, 88261.55869220741, 93467.53266233625, 94230.52884735669, 94243.52878235564, 95400.52299738457, 49539.0, 64934.0, 78975.60512197402, 79515.20484795078, 79774.60112699516, 67586.324136758, 68510.65744671244, 68947.0, 69182.0, 69428.0, 8779.956100219459, 8894.4663320201, 8989.685361012333, 9095.317851161057, 9127.359776375532, 49899.0, 50732.0, 50746.0, 51192.74403628107, 52585.7370713144, 64248.0, 68711.65644171747, 70137.64931175312, 70486.64756676184, 73188.63405682938, 11539.942300288445, 11719.472623732123, 11730.12024098213, 11812.0, 11952.0, 12964.481420743441, 12968.546100886424, 13091.083624146599, 13262.27057511846, 13961.860381396056, 11744.530218791153, 11777.234479758788, 11878.82181767257, 12204.08469364819, 12573.371331433575, 12381.319027453215, 12760.106792524433, 12790.61628151157, 13294.401751920994, 13308.600741977756, 11697.649070527897, 11806.350650714294, 11993.040556755614, 12376.81434778461, 12735.108542402313, 10137.64518241858, 10232.64185753495, 10252.128569071712, 10425.739356515844, 10627.840582391116, 10477.9476102619, 10499.0, 10580.259381843505, 10670.19973502006, 10734.785304293715], "value": 7257.123929499911, "unit": "score"}], "name": "dromaeo_css", "value": 7395.573717346091, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 119.0, 112.0, 114.0, 112.0, 112.0, 111.0, 110.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 120.0, 166.0, 125.0, 117.0, 118.0, 118.0, 146.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 160.0, 160.0, 160.0, 161.0, 159.0, 161.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 115.0, 76.0, 76.0, 76.0, 75.0, 98.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 82.0, 81.0, 81.0, 97.0, 82.0, 83.0, 117.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 53.0, 50.0, 51.0, 49.0, 52.0, 50.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 58.0, 59.0, 57.0, 58.0, 58.0, 59.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 75.0, 80.0, 75.0, 77.0, 76.0, 73.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 124.0, 136.0, 121.0, 120.0, 133.0, 118.0, 154.0, 139.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 155.0, 157.0, 153.0, 154.0, 154.0, 166.0, 156.0, 159.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 62.0, 64.0, 63.0, 62.0, 64.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1454.1999999999998, "alertThreshold": 2.0}]} 01:42:08 INFO - Return code: 0 01:42:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:42:08 INFO - # TBPL SUCCESS # 01:42:08 INFO - Running post-action listener: _resource_record_post_action 01:42:08 INFO - [mozharness: 2017-01-09 09:42:08.334144Z] Finished run-tests step (success) 01:42:08 INFO - Running post-run listener: _resource_record_post_run 01:42:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 262144; Write bytes: 356986880; Read time: 16; Write time: 179108 01:42:08 INFO - TinderboxPrint: CPU usage
13.0% 01:42:08 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 01:42:08 INFO - TinderboxPrint: I/O write bytes / time
356,986,880 / 179,108 01:42:08 INFO - TinderboxPrint: CPU idle
8,265.6 (87.0%) 01:42:08 INFO - TinderboxPrint: CPU user
1,190.6 (12.5%) 01:42:08 INFO - TinderboxPrint: Swap in / out
0 / 0 01:42:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107753472; Read time: 0; Write time: 68104 01:42:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 237498368; Read time: 16; Write time: 105048 01:42:08 INFO - Running post-run listener: _upload_blobber_files 01:42:08 INFO - Blob upload gear active. 01:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:42:08 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 01:42:08 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:42:08 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:42:09 INFO - (blobuploader) - INFO - Open directory for files ... 01:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:10 INFO - (blobuploader) - INFO - Done attempting. 01:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:42:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:13 INFO - (blobuploader) - INFO - Done attempting. 01:42:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:42:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:14 INFO - (blobuploader) - INFO - Done attempting. 01:42:14 INFO - (blobuploader) - INFO - Iteration through files over. 01:42:14 INFO - Return code: 0 01:42:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:42:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:42:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085de62d141722555e40b8ff50c4ff726b2741c51dab721d6fdb069ce4de1e81769f28b83f209579418f69358a29308789324c325d0fd39389ee43bf30e14810", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f38db7cc590b86a8e955c0fb447ac3c0d6daaebd92b979eb6dfaa39c6cfcb03c5231480d3884d28417225a33c32c681564e14ca02404856eb1477332446613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa5a8002edc0b969e4516e026a2e65e05d6a421590be3ebab7090213f86c42f2a85dd4e12438a7ebdb0eb568e327986abda6e940891b3af9600b3c5793ff5fb9"} 01:42:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:42:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:42:14 INFO - Contents: 01:42:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085de62d141722555e40b8ff50c4ff726b2741c51dab721d6fdb069ce4de1e81769f28b83f209579418f69358a29308789324c325d0fd39389ee43bf30e14810", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f38db7cc590b86a8e955c0fb447ac3c0d6daaebd92b979eb6dfaa39c6cfcb03c5231480d3884d28417225a33c32c681564e14ca02404856eb1477332446613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa5a8002edc0b969e4516e026a2e65e05d6a421590be3ebab7090213f86c42f2a85dd4e12438a7ebdb0eb568e327986abda6e940891b3af9600b3c5793ff5fb9"} 01:42:14 INFO - Running post-run listener: copy_logs_to_upload_dir 01:42:14 INFO - Copying logs to upload dir... 01:42:14 INFO - mkdir: /builds/slave/test/build/upload/logs 01:42:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.499762 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-09 01:42:13.349223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 01:42:13.356498) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085de62d141722555e40b8ff50c4ff726b2741c51dab721d6fdb069ce4de1e81769f28b83f209579418f69358a29308789324c325d0fd39389ee43bf30e14810", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f38db7cc590b86a8e955c0fb447ac3c0d6daaebd92b979eb6dfaa39c6cfcb03c5231480d3884d28417225a33c32c681564e14ca02404856eb1477332446613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa5a8002edc0b969e4516e026a2e65e05d6a421590be3ebab7090213f86c42f2a85dd4e12438a7ebdb0eb568e327986abda6e940891b3af9600b3c5793ff5fb9"} build_url:https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/IPKdpPKnTUGL2HfZotdayg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/085de62d141722555e40b8ff50c4ff726b2741c51dab721d6fdb069ce4de1e81769f28b83f209579418f69358a29308789324c325d0fd39389ee43bf30e14810", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2f38db7cc590b86a8e955c0fb447ac3c0d6daaebd92b979eb6dfaa39c6cfcb03c5231480d3884d28417225a33c32c681564e14ca02404856eb1477332446613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa5a8002edc0b969e4516e026a2e65e05d6a421590be3ebab7090213f86c42f2a85dd4e12438a7ebdb0eb568e327986abda6e940891b3af9600b3c5793ff5fb9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 01:42:13.389394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:42:13.389756) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1483952161.750122-1736670232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 01:42:13.473429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 01:42:13.473807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 01:42:13.474161) ========= ========= Total master_lag: 0.19 =========