builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1479138630.81 results: success (0) buildid: 20161114060943 builduid: 4c048b8ac3ec4a219ea40e049fcf6ad9 revision: 458c900dd4ef310d5bffae1f2bb97da50839cc66 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.813379) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.814017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.814300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.829701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.830156) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 07:50:31-- 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% 70.0M=0s 2016-11-14 07:50:31 (70.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.944770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.945130) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019343 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.994527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:30.994901) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 458c900dd4ef310d5bffae1f2bb97da50839cc66 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 458c900dd4ef310d5bffae1f2bb97da50839cc66 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 07:50:31,411 truncating revision to first 12 chars 2016-11-14 07:50:31,411 Setting DEBUG logging. 2016-11-14 07:50:31,411 attempt 1/10 2016-11-14 07:50:31,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/458c900dd4ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 07:50:31,794 unpacking tar archive at: mozilla-central-458c900dd4ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723625 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:31.732031) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:31.732360) ========= script_repo_revision: 458c900dd4ef310d5bffae1f2bb97da50839cc66 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:31.732758) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:31.733025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:50:31.742923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-14 07:50:31.743337) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:50:32 INFO - MultiFileLogger online at 20161114 07:50:32 in /builds/slave/test 07:50:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:50:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:50:32 INFO - {'append_to_log': False, 07:50:32 INFO - 'base_work_dir': '/builds/slave/test', 07:50:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:50:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:50:32 INFO - 'branch': 'Firefox-Non-PGO', 07:50:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:50:32 INFO - 'config_files': ('talos/linux_config.py',), 07:50:32 INFO - 'default_actions': ('clobber', 07:50:32 INFO - 'read-buildbot-config', 07:50:32 INFO - 'download-and-extract', 07:50:32 INFO - 'populate-webroot', 07:50:32 INFO - 'create-virtualenv', 07:50:32 INFO - 'install', 07:50:32 INFO - 'run-tests'), 07:50:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:50:32 INFO - 'download_minidump_stackwalk': True, 07:50:32 INFO - 'download_symbols': 'ondemand', 07:50:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:50:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:50:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:50:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:50:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:50:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:50:32 INFO - 'installer_path': 'installer.exe', 07:50:32 INFO - 'log_level': 'info', 07:50:32 INFO - 'log_name': 'talos', 07:50:32 INFO - 'log_to_console': True, 07:50:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:50:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:50:32 INFO - 'opt_config_files': (), 07:50:32 INFO - 'pip_index': False, 07:50:32 INFO - 'sps_profile': False, 07:50:32 INFO - 'sps_profile_interval': 0, 07:50:32 INFO - 'suite': 'dromaeojs', 07:50:32 INFO - 'system_bits': '32', 07:50:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:50:32 INFO - 'title': 'talos-linux64-ix-002', 07:50:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:50:32 INFO - 'use_talos_json': True, 07:50:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:50:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:50:32 INFO - 'work_dir': 'build'} 07:50:32 INFO - [mozharness: 2016-11-14 15:50:32.250395Z] Running clobber step. 07:50:32 INFO - Running pre-action listener: _resource_record_pre_action 07:50:32 INFO - Running main action method: clobber 07:50:32 INFO - rmtree: /builds/slave/test/build 07:50:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:50:32 INFO - Running post-action listener: _resource_record_post_action 07:50:32 INFO - [mozharness: 2016-11-14 15:50:32.717881Z] Finished clobber step (success) 07:50:32 INFO - [mozharness: 2016-11-14 15:50:32.717994Z] Running read-buildbot-config step. 07:50:32 INFO - Running pre-action listener: _resource_record_pre_action 07:50:32 INFO - Running main action method: read_buildbot_config 07:50:32 INFO - Using buildbot properties: 07:50:32 INFO - { 07:50:32 INFO - "project": "", 07:50:32 INFO - "product": "firefox", 07:50:32 INFO - "script_repo_revision": "production", 07:50:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:50:32 INFO - "repository": "", 07:50:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:50:32 INFO - "buildid": "20161114060943", 07:50:32 INFO - "pgo_build": "False", 07:50:32 INFO - "basedir": "/builds/slave/test", 07:50:32 INFO - "buildnumber": 810, 07:50:32 INFO - "slavename": "talos-linux64-ix-002", 07:50:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:50:32 INFO - "platform": "ubuntu64_hw", 07:50:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:50:32 INFO - "branch": "mozilla-central", 07:50:32 INFO - "repo_path": "mozilla-central", 07:50:32 INFO - "revision": "458c900dd4ef310d5bffae1f2bb97da50839cc66", 07:50:32 INFO - "stage_platform": "linux64", 07:50:32 INFO - "builduid": "4c048b8ac3ec4a219ea40e049fcf6ad9", 07:50:32 INFO - "slavebuilddir": "test" 07:50:32 INFO - } 07:50:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:50:32 INFO - Running post-action listener: _resource_record_post_action 07:50:32 INFO - [mozharness: 2016-11-14 15:50:32.720405Z] Finished read-buildbot-config step (success) 07:50:32 INFO - [mozharness: 2016-11-14 15:50:32.720493Z] Running download-and-extract step. 07:50:32 INFO - Running pre-action listener: _resource_record_pre_action 07:50:32 INFO - Running main action method: download_and_extract 07:50:32 INFO - mkdir: /builds/slave/test/build/tests 07:50:32 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')]} 07:50:32 INFO - trying https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:50:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:50:33 INFO - Downloaded 1361 bytes. 07:50:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:50:33 INFO - Using the following test package requirements: 07:50:33 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:50:33 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:50:33 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:50:33 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'jsshell-linux-x86_64.zip'], 07:50:33 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:50:33 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:50:33 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:50:33 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:50:33 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:50:33 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:50:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:50:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:50:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:50:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:50:33 INFO - Http code: 200 07:50:33 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 07:50:33 INFO - x-amz-cf-id: ec250Mw7I_xVOAzGaOMPE_EoqzpVt_cuRTdYAu8NmC2Z_pCfEjgb4g== 07:50:33 INFO - x-amz-version-id: oh7fnryo79QkPLYvj81ASucOnb9N2ZeQ 07:50:34 INFO - Expected file size: 20414491 07:50:34 INFO - Obtained file size: 20414491 07:50:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:50:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:50:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:50:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:50:38 INFO - Http code: 200 07:50:38 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:50:38 INFO - x-amz-cf-id: hOJhaCO-LJ54_vyB7c74qsL2Ca4EvO1gAqfgFdz3YtpwOMpeo1PZiA== 07:50:38 INFO - x-amz-version-id: oh7fnryo79QkPLYvj81ASucOnb9N2ZeQ 07:50:39 INFO - Expected file size: 20414491 07:50:39 INFO - Obtained file size: 20414491 07:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:50:44 INFO - Http code: 200 07:50:44 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 07:50:44 INFO - x-amz-cf-id: xXybEXuDhG5TZ3MZ7lWeNQsngu3f9mUNZgwuc27wrq514Nd9w6VFkg== 07:50:44 INFO - x-amz-version-id: G6CyBT.VsqHFEE1CywlTGnxse29VxNpJ 07:50:44 INFO - Expected file size: 14409038 07:50:44 INFO - Obtained file size: 14409038 07:50:44 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')]} 07:50:44 INFO - trying https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:50:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:50:45 INFO - Downloaded 55696800 bytes. 07:50:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:50:45 INFO - mkdir: /builds/slave/test/properties 07:50:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:45 INFO - Contents: 07:50:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:50:46 INFO - Running post-action listener: _resource_record_post_action 07:50:46 INFO - Running post-action listener: set_extra_try_arguments 07:50:46 INFO - [mozharness: 2016-11-14 15:50:46.433980Z] Finished download-and-extract step (success) 07:50:46 INFO - [mozharness: 2016-11-14 15:50:46.434214Z] Running populate-webroot step. 07:50:46 INFO - Running pre-action listener: _resource_record_pre_action 07:50:46 INFO - Running main action method: populate_webroot 07:50:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:46 INFO - '--tppagecycles', 07:50:46 INFO - '7'], 07:50:46 INFO - 'tests': ['tsvgm']}}, 07:50:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:50:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:50:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:50:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['damp', 'tps']}, 07:50:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'tests': ['damp', 'tps']}, 07:50:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['dromaeo_dom']}, 07:50:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:50:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['basic_compositor_video']}, 07:50:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:50:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['a11yr', 07:50:46 INFO - 'ts_paint', 07:50:46 INFO - 'tpaint', 07:50:46 INFO - 'sessionrestore', 07:50:46 INFO - 'sessionrestore_no_auto_restore', 07:50:46 INFO - 'tabpaint']}, 07:50:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:50:46 INFO - 'ts_paint', 07:50:46 INFO - 'tpaint', 07:50:46 INFO - 'sessionrestore', 07:50:46 INFO - 'sessionrestore_no_auto_restore', 07:50:46 INFO - 'tabpaint']}, 07:50:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:50:46 INFO - 'ts_paint', 07:50:46 INFO - 'tpaint', 07:50:46 INFO - 'sessionrestore', 07:50:46 INFO - 'sessionrestore_no_auto_restore', 07:50:46 INFO - 'tabpaint']}, 07:50:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:50:46 INFO - 'ts_paint', 07:50:46 INFO - 'tpaint', 07:50:46 INFO - 'sessionrestore', 07:50:46 INFO - 'sessionrestore_no_auto_restore', 07:50:46 INFO - 'tabpaint']}, 07:50:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['a11yr', 07:50:46 INFO - 'ts_paint', 07:50:46 INFO - 'tpaint', 07:50:46 INFO - 'sessionrestore', 07:50:46 INFO - 'sessionrestore_no_auto_restore', 07:50:46 INFO - 'tabpaint']}, 07:50:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['a11yr', 07:50:46 INFO - 'ts_paint', 07:50:46 INFO - 'tpaint', 07:50:46 INFO - 'sessionrestore', 07:50:46 INFO - 'sessionrestore_no_auto_restore', 07:50:46 INFO - 'tabpaint']}, 07:50:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['tsvgx', 07:50:46 INFO - 'tsvgr_opacity', 07:50:46 INFO - 'tart', 07:50:46 INFO - 'tscrollx', 07:50:46 INFO - 'cart']}, 07:50:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:50:46 INFO - 'tsvgr_opacity', 07:50:46 INFO - 'tart', 07:50:46 INFO - 'tscrollx', 07:50:46 INFO - 'cart']}, 07:50:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'talos_options': ['--disable-e10s'], 07:50:46 INFO - 'tests': ['tp5o']}, 07:50:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'tests': ['tp5o']}, 07:50:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'talos_options': ['--disable-e10s', 07:50:46 INFO - '--xperf_path', 07:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:46 INFO - 'tests': ['tp5n']}, 07:50:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:46 INFO - 'talos_options': ['--xperf_path', 07:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:46 INFO - 'tests': ['tp5n']}}, 07:50:46 INFO - 'talos.zip': {'path': '', 07:50:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:46 INFO - Running post-action listener: _resource_record_post_action 07:50:46 INFO - [mozharness: 2016-11-14 15:50:46.452559Z] Finished populate-webroot step (success) 07:50:46 INFO - [mozharness: 2016-11-14 15:50:46.452647Z] Running create-virtualenv step. 07:50:46 INFO - Running pre-action listener: _resource_record_pre_action 07:50:46 INFO - Running main action method: create_virtualenv 07:50:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50:46 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 07:50:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:46 INFO - Using real prefix '/usr' 07:50:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:50:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:49 INFO - Installing pip.................done. 07:50:49 INFO - Return code: 0 07:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:50:49 INFO - Reading from file tmpfile_stdout 07:50:49 INFO - Output received: 07:50:49 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) 07:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:50:49 INFO - Using env: {'DISPLAY': ':0', 07:50:49 INFO - 'HOME': '/home/cltbld', 07:50:49 INFO - 'LANG': 'en_US.UTF-8', 07:50:49 INFO - 'LANGUAGE': 'en_US:en', 07:50:49 INFO - 'LOGNAME': 'cltbld', 07:50:49 INFO - 'MAIL': '/var/mail/cltbld', 07:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:49 INFO - 'MOZ_NO_REMOTE': '1', 07:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:49 INFO - 'NO_EM_RESTART': '1', 07:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:49 INFO - 'PWD': '/builds/slave/test', 07:50:49 INFO - 'SHELL': '/bin/bash', 07:50:49 INFO - 'SHLVL': '1', 07:50:49 INFO - 'TERM': 'linux', 07:50:49 INFO - 'TMOUT': '86400', 07:50:49 INFO - 'USER': 'cltbld', 07:50:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:49 INFO - '_': '/tools/buildbot/bin/python'} 07:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:49 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 07:50:49 INFO - Cleaning up... 07:50:49 INFO - Return code: 0 07:50:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:50:49 INFO - Using env: {'DISPLAY': ':0', 07:50:49 INFO - 'HOME': '/home/cltbld', 07:50:49 INFO - 'LANG': 'en_US.UTF-8', 07:50:49 INFO - 'LANGUAGE': 'en_US:en', 07:50:49 INFO - 'LOGNAME': 'cltbld', 07:50:49 INFO - 'MAIL': '/var/mail/cltbld', 07:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:49 INFO - 'MOZ_NO_REMOTE': '1', 07:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:49 INFO - 'NO_EM_RESTART': '1', 07:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:49 INFO - 'PWD': '/builds/slave/test', 07:50:49 INFO - 'SHELL': '/bin/bash', 07:50:49 INFO - 'SHLVL': '1', 07:50:49 INFO - 'TERM': 'linux', 07:50:49 INFO - 'TMOUT': '86400', 07:50:49 INFO - 'USER': 'cltbld', 07:50:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:49 INFO - '_': '/tools/buildbot/bin/python'} 07:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:49 INFO - Downloading/unpacking psutil>=3.1.1 07:50:49 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 07:50:49 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 07:50:49 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 07:50:49 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 07:50:49 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 07:50:49 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 07:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:51 INFO - Installing collected packages: psutil 07:50:51 INFO - Running setup.py install for psutil 07:50:51 INFO - building 'psutil._psutil_linux' extension 07:50:51 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 07:50:51 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 07:50:51 INFO - building 'psutil._psutil_posix' extension 07:50:51 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 07:50:52 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 07:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:52 INFO - Successfully installed psutil 07:50:52 INFO - Cleaning up... 07:50:52 INFO - Return code: 0 07:50:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:52 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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:50:52 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 07:50:52 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 07:50:52 INFO - Using env: {'DISPLAY': ':0', 07:50:52 INFO - 'HOME': '/home/cltbld', 07:50:52 INFO - 'LANG': 'en_US.UTF-8', 07:50:52 INFO - 'LANGUAGE': 'en_US:en', 07:50:52 INFO - 'LOGNAME': 'cltbld', 07:50:52 INFO - 'MAIL': '/var/mail/cltbld', 07:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:52 INFO - 'MOZ_NO_REMOTE': '1', 07:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:52 INFO - 'NO_EM_RESTART': '1', 07:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:52 INFO - 'PWD': '/builds/slave/test', 07:50:52 INFO - 'SHELL': '/bin/bash', 07:50:52 INFO - 'SHLVL': '1', 07:50:52 INFO - 'TERM': 'linux', 07:50:52 INFO - 'TMOUT': '86400', 07:50:52 INFO - 'USER': 'cltbld', 07:50:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:52 INFO - '_': '/tools/buildbot/bin/python'} 07:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:50:52 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 07:50:52 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 07:50:52 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 07:50:52 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 07:50:52 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 07:50:52 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 07:50:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:50:54 INFO - Installing collected packages: mozsystemmonitor 07:50:54 INFO - Running setup.py install for mozsystemmonitor 07:50:54 INFO - Successfully installed mozsystemmonitor 07:50:54 INFO - Cleaning up... 07:50:54 INFO - Return code: 0 07:50:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:54 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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:50:54 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 07:50:54 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 07:50:54 INFO - Using env: {'DISPLAY': ':0', 07:50:54 INFO - 'HOME': '/home/cltbld', 07:50:54 INFO - 'LANG': 'en_US.UTF-8', 07:50:54 INFO - 'LANGUAGE': 'en_US:en', 07:50:54 INFO - 'LOGNAME': 'cltbld', 07:50:54 INFO - 'MAIL': '/var/mail/cltbld', 07:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:54 INFO - 'MOZ_NO_REMOTE': '1', 07:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:54 INFO - 'NO_EM_RESTART': '1', 07:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:54 INFO - 'PWD': '/builds/slave/test', 07:50:54 INFO - 'SHELL': '/bin/bash', 07:50:54 INFO - 'SHLVL': '1', 07:50:54 INFO - 'TERM': 'linux', 07:50:54 INFO - 'TMOUT': '86400', 07:50:54 INFO - 'USER': 'cltbld', 07:50:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:54 INFO - '_': '/tools/buildbot/bin/python'} 07:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:54 INFO - Downloading/unpacking jsonschema==2.5.1 07:50:54 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 07:50:54 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 07:50:54 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 07:50:54 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 07:50:54 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 07:50:54 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 07:50:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:50:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:50:56 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 07:50:56 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 07:50:56 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 07:50:56 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 07:50:56 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 07:50:56 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 07:50:56 INFO - Downloading functools32-3.2.3-2.tar.gz 07:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:50:57 INFO - warning: no files found matching '*.txt' 07:50:57 INFO - no previously-included directories found matching 'build' 07:50:57 INFO - no previously-included directories found matching 'dist' 07:50:57 INFO - no previously-included directories found matching '.git*' 07:50:57 INFO - Installing collected packages: jsonschema, functools32 07:50:57 INFO - Running setup.py install for functools32 07:50:57 INFO - warning: no files found matching '*.txt' 07:50:57 INFO - no previously-included directories found matching 'build' 07:50:57 INFO - no previously-included directories found matching 'dist' 07:50:57 INFO - no previously-included directories found matching '.git*' 07:50:57 INFO - Successfully installed jsonschema functools32 07:50:57 INFO - Cleaning up... 07:50:57 INFO - Return code: 0 07:50:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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', '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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:50: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:50: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 functools32==3.2.3-2 07:50:57 INFO - Using env: {'DISPLAY': ':0', 07:50:57 INFO - 'HOME': '/home/cltbld', 07:50:57 INFO - 'LANG': 'en_US.UTF-8', 07:50:57 INFO - 'LANGUAGE': 'en_US:en', 07:50:57 INFO - 'LOGNAME': 'cltbld', 07:50:57 INFO - 'MAIL': '/var/mail/cltbld', 07:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:57 INFO - 'MOZ_NO_REMOTE': '1', 07:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:57 INFO - 'NO_EM_RESTART': '1', 07:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:57 INFO - 'PWD': '/builds/slave/test', 07:50:57 INFO - 'SHELL': '/bin/bash', 07:50:57 INFO - 'SHLVL': '1', 07:50:57 INFO - 'TERM': 'linux', 07:50:57 INFO - 'TMOUT': '86400', 07:50:57 INFO - 'USER': 'cltbld', 07:50:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:57 INFO - '_': '/tools/buildbot/bin/python'} 07:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:50:57 INFO - Cleaning up... 07:50:57 INFO - Return code: 0 07:50:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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', '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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:50: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 blobuploader==1.2.4 07:50:57 INFO - Using env: {'DISPLAY': ':0', 07:50:57 INFO - 'HOME': '/home/cltbld', 07:50:57 INFO - 'LANG': 'en_US.UTF-8', 07:50:57 INFO - 'LANGUAGE': 'en_US:en', 07:50:57 INFO - 'LOGNAME': 'cltbld', 07:50:57 INFO - 'MAIL': '/var/mail/cltbld', 07:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:57 INFO - 'MOZ_NO_REMOTE': '1', 07:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:57 INFO - 'NO_EM_RESTART': '1', 07:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:57 INFO - 'PWD': '/builds/slave/test', 07:50:57 INFO - 'SHELL': '/bin/bash', 07:50:57 INFO - 'SHLVL': '1', 07:50:57 INFO - 'TERM': 'linux', 07:50:57 INFO - 'TMOUT': '86400', 07:50:57 INFO - 'USER': 'cltbld', 07:50:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:57 INFO - '_': '/tools/buildbot/bin/python'} 07:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:57 INFO - Downloading/unpacking blobuploader==1.2.4 07:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:59 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 07:50:59 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 07:50:59 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 07:50:59 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 07:50:59 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 07:50:59 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 07:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:00 INFO - Downloading docopt-0.6.1.tar.gz 07:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 07:51:00 INFO - Running setup.py install for blobuploader 07:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:51:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:51:00 INFO - Running setup.py install for requests 07:51:00 INFO - Running setup.py install for docopt 07:51:00 INFO - Successfully installed blobuploader requests docopt 07:51:00 INFO - Cleaning up... 07:51:01 INFO - Return code: 0 07:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:01 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')]} 07:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:01 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')]} 07:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:01 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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:51:01 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 07:51:01 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 07:51:01 INFO - Using env: {'DISPLAY': ':0', 07:51:01 INFO - 'HOME': '/home/cltbld', 07:51:01 INFO - 'LANG': 'en_US.UTF-8', 07:51:01 INFO - 'LANGUAGE': 'en_US:en', 07:51:01 INFO - 'LOGNAME': 'cltbld', 07:51:01 INFO - 'MAIL': '/var/mail/cltbld', 07:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:01 INFO - 'MOZ_NO_REMOTE': '1', 07:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:01 INFO - 'NO_EM_RESTART': '1', 07:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:01 INFO - 'PWD': '/builds/slave/test', 07:51:01 INFO - 'SHELL': '/bin/bash', 07:51:01 INFO - 'SHLVL': '1', 07:51:01 INFO - 'TERM': 'linux', 07:51:01 INFO - 'TMOUT': '86400', 07:51:01 INFO - 'USER': 'cltbld', 07:51:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:01 INFO - '_': '/tools/buildbot/bin/python'} 07:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:01 INFO - Running setup.py (path:/tmp/pip-TPOfbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:01 INFO - Running setup.py (path:/tmp/pip-Two0by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:01 INFO - Running setup.py (path:/tmp/pip-RYLt7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:01 INFO - Running setup.py (path:/tmp/pip-TSvdpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:01 INFO - Running setup.py (path:/tmp/pip-YdEz6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:01 INFO - Running setup.py (path:/tmp/pip-cc2djN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:01 INFO - Running setup.py (path:/tmp/pip-Zq9oQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:01 INFO - Running setup.py (path:/tmp/pip-IrW2vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:01 INFO - Running setup.py (path:/tmp/pip-3dbPCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:01 INFO - Running setup.py (path:/tmp/pip-8b83IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:01 INFO - Running setup.py (path:/tmp/pip-Y4A5zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:02 INFO - Running setup.py (path:/tmp/pip-wMzRZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:02 INFO - Running setup.py (path:/tmp/pip-8TAVHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:02 INFO - Running setup.py (path:/tmp/pip-BVXdMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:02 INFO - Running setup.py (path:/tmp/pip-tw7ZPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:02 INFO - Running setup.py (path:/tmp/pip-BdOdM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:02 INFO - Running setup.py (path:/tmp/pip-1KiTe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:51:02 INFO - Running setup.py install for manifestparser 07:51:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:51:02 INFO - Running setup.py install for mozcrash 07:51:02 INFO - Running setup.py install for mozdebug 07:51:02 INFO - Running setup.py install for mozdevice 07:51:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:51:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:51:02 INFO - Running setup.py install for mozfile 07:51:03 INFO - Running setup.py install for mozhttpd 07:51:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for mozinfo 07:51:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for mozInstall 07:51:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for mozleak 07:51:03 INFO - Running setup.py install for mozlog 07:51:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for moznetwork 07:51:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for mozprocess 07:51:03 INFO - Running setup.py install for mozprofile 07:51:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for mozrunner 07:51:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:51:03 INFO - Running setup.py install for mozscreenshot 07:51:04 INFO - Running setup.py install for moztest 07:51:04 INFO - Running setup.py install for mozversion 07:51:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:51:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:51:04 INFO - Cleaning up... 07:51:04 INFO - Return code: 0 07:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:04 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')]} 07:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:04 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')]} 07:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:04 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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:51:04 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 07:51:04 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 07:51:04 INFO - Using env: {'DISPLAY': ':0', 07:51:04 INFO - 'HOME': '/home/cltbld', 07:51:04 INFO - 'LANG': 'en_US.UTF-8', 07:51:04 INFO - 'LANGUAGE': 'en_US:en', 07:51:04 INFO - 'LOGNAME': 'cltbld', 07:51:04 INFO - 'MAIL': '/var/mail/cltbld', 07:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:04 INFO - 'MOZ_NO_REMOTE': '1', 07:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:04 INFO - 'NO_EM_RESTART': '1', 07:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:04 INFO - 'PWD': '/builds/slave/test', 07:51:04 INFO - 'SHELL': '/bin/bash', 07:51:04 INFO - 'SHLVL': '1', 07:51:04 INFO - 'TERM': 'linux', 07:51:04 INFO - 'TMOUT': '86400', 07:51:04 INFO - 'USER': 'cltbld', 07:51:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:04 INFO - '_': '/tools/buildbot/bin/python'} 07:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:04 INFO - Running setup.py (path:/tmp/pip-xYP4S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:04 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)) 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:04 INFO - Running setup.py (path:/tmp/pip-MxbVhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:04 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)) 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:04 INFO - Running setup.py (path:/tmp/pip-g85X6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:04 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)) 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:04 INFO - Running setup.py (path:/tmp/pip-iGuMPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:04 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)) 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:04 INFO - Running setup.py (path:/tmp/pip-6unwf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:04 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)) 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:04 INFO - Running setup.py (path:/tmp/pip-l_jEwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:04 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)) 07:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:04 INFO - Running setup.py (path:/tmp/pip-26anAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:05 INFO - Running setup.py (path:/tmp/pip-GafBGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:05 INFO - Running setup.py (path:/tmp/pip-sWDlMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:05 INFO - Running setup.py (path:/tmp/pip-7psdYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:05 INFO - Running setup.py (path:/tmp/pip-meVcuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:05 INFO - Running setup.py (path:/tmp/pip-OoUJmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:05 INFO - Running setup.py (path:/tmp/pip-KMu__g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:05 INFO - Running setup.py (path:/tmp/pip-XvSsHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:05 INFO - Running setup.py (path:/tmp/pip-TftF8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:05 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)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:05 INFO - Running setup.py (path:/tmp/pip-5mg05K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:05 INFO - Running setup.py (path:/tmp/pip-88V9n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:05 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)) 07:51:05 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)) 07:51:05 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)) 07:51:05 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)) 07:51:05 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)) 07:51:05 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)) 07:51:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51:07 INFO - Downloading blessings-1.6.tar.gz 07:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:51:07 INFO - Installing collected packages: blessings 07:51:07 INFO - Running setup.py install for blessings 07:51:07 INFO - Successfully installed blessings 07:51:07 INFO - Cleaning up... 07:51:07 INFO - Return code: 0 07:51:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:51:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:08 INFO - Reading from file tmpfile_stdout 07:51:08 INFO - Current package versions: 07:51:08 INFO - argparse == 1.2.1 07:51:08 INFO - blessings == 1.6 07:51:08 INFO - blobuploader == 1.2.4 07:51:08 INFO - docopt == 0.6.1 07:51:08 INFO - functools32 == 3.2.3-2 07:51:08 INFO - jsonschema == 2.5.1 07:51:08 INFO - manifestparser == 1.1 07:51:08 INFO - mozInstall == 1.12 07:51:08 INFO - mozcrash == 1.0 07:51:08 INFO - mozdebug == 0.1 07:51:08 INFO - mozdevice == 0.48 07:51:08 INFO - mozfile == 1.2 07:51:08 INFO - mozhttpd == 0.7 07:51:08 INFO - mozinfo == 0.9 07:51:08 INFO - mozleak == 0.1 07:51:08 INFO - mozlog == 3.4 07:51:08 INFO - moznetwork == 0.27 07:51:08 INFO - mozprocess == 0.23 07:51:08 INFO - mozprofile == 0.28 07:51:08 INFO - mozrunner == 6.13 07:51:08 INFO - mozscreenshot == 0.1 07:51:08 INFO - mozsystemmonitor == 0.3 07:51:08 INFO - moztest == 0.7 07:51:08 INFO - mozversion == 1.4 07:51:08 INFO - psutil == 3.1.1 07:51:08 INFO - requests == 1.2.3 07:51:08 INFO - wsgiref == 0.1.2 07:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:08 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')]} 07:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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')]} 07:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:51:08 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 07:51:08 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 07:51:08 INFO - Using env: {'DISPLAY': ':0', 07:51:08 INFO - 'HOME': '/home/cltbld', 07:51:08 INFO - 'LANG': 'en_US.UTF-8', 07:51:08 INFO - 'LANGUAGE': 'en_US:en', 07:51:08 INFO - 'LOGNAME': 'cltbld', 07:51:08 INFO - 'MAIL': '/var/mail/cltbld', 07:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:08 INFO - 'MOZ_NO_REMOTE': '1', 07:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:08 INFO - 'NO_EM_RESTART': '1', 07:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:08 INFO - 'PWD': '/builds/slave/test', 07:51:08 INFO - 'SHELL': '/bin/bash', 07:51:08 INFO - 'SHLVL': '1', 07:51:08 INFO - 'TERM': 'linux', 07:51:08 INFO - 'TMOUT': '86400', 07:51:08 INFO - 'USER': 'cltbld', 07:51:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:08 INFO - '_': '/tools/buildbot/bin/python'} 07:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 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)) 07:51:08 INFO - Cleaning up... 07:51:08 INFO - Return code: 0 07:51:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:51:08 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')]} 07:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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')]} 07:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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 0x7fbcb8d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x132e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', '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 07:51:08 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 07:51:08 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 07:51:08 INFO - Using env: {'DISPLAY': ':0', 07:51:08 INFO - 'HOME': '/home/cltbld', 07:51:08 INFO - 'LANG': 'en_US.UTF-8', 07:51:08 INFO - 'LANGUAGE': 'en_US:en', 07:51:08 INFO - 'LOGNAME': 'cltbld', 07:51:08 INFO - 'MAIL': '/var/mail/cltbld', 07:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:08 INFO - 'MOZ_NO_REMOTE': '1', 07:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:08 INFO - 'NO_EM_RESTART': '1', 07:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:08 INFO - 'PWD': '/builds/slave/test', 07:51:08 INFO - 'SHELL': '/bin/bash', 07:51:08 INFO - 'SHLVL': '1', 07:51:08 INFO - 'TERM': 'linux', 07:51:08 INFO - 'TMOUT': '86400', 07:51:08 INFO - 'USER': 'cltbld', 07:51:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:08 INFO - '_': '/tools/buildbot/bin/python'} 07:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:51:08 INFO - Cleaning up... 07:51:08 INFO - Return code: 0 07:51:08 INFO - Running post-action listener: _resource_record_post_action 07:51:08 INFO - Running post-action listener: _start_resource_monitoring 07:51:08 INFO - Starting resource monitoring. 07:51:08 INFO - [mozharness: 2016-11-14 15:51:08.689006Z] Finished create-virtualenv step (success) 07:51:08 INFO - [mozharness: 2016-11-14 15:51:08.689982Z] Running install step. 07:51:08 INFO - Running pre-action listener: _resource_record_pre_action 07:51:08 INFO - Running main action method: install 07:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:08 INFO - Reading from file tmpfile_stdout 07:51:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:51:08 INFO - Reading from file tmpfile_stdout 07:51:08 INFO - Output received: 07:51:08 INFO - Usage: mozinstall [options] installer 07:51:08 INFO - Options: 07:51:08 INFO - -h, --help show this help message and exit 07:51:08 INFO - -d DEST, --destination=DEST 07:51:08 INFO - Directory to install application into. [default: 07:51:08 INFO - "/builds/slave/test"] 07:51:08 INFO - --app=APP Application being installed. [default: firefox] 07:51:08 INFO - mkdir: /builds/slave/test/build/application 07:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:51:25 INFO - Reading from file tmpfile_stdout 07:51:25 INFO - Output received: 07:51:25 INFO - /builds/slave/test/build/application/firefox/firefox 07:51:25 INFO - Running post-action listener: _resource_record_post_action 07:51:25 INFO - [mozharness: 2016-11-14 15:51:25.055280Z] Finished install step (success) 07:51:25 INFO - [mozharness: 2016-11-14 15:51:25.055525Z] Running run-tests step. 07:51:25 INFO - Running pre-action listener: _resource_record_pre_action 07:51:25 INFO - Running main action method: run_tests 07:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:51:25 INFO - Python 2.7.3 07:51:25 INFO - Return code: 0 07:51:25 INFO - grabbing minidump binary from tooltool 07:51:25 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')]} 07:51:25 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 0x13f8f60>, '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 0x13f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:51:25 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 07:51:25 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 07:51:25 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 07:51:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:51:25 INFO - Return code: 0 07:51:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:51:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:51:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:51:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:51:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:51:25 INFO - Using env: {'DISPLAY': ':0', 07:51:25 INFO - 'HOME': '/home/cltbld', 07:51:25 INFO - 'LANG': 'en_US.UTF-8', 07:51:25 INFO - 'LANGUAGE': 'en_US:en', 07:51:25 INFO - 'LOGNAME': 'cltbld', 07:51:25 INFO - 'MAIL': '/var/mail/cltbld', 07:51:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:51:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:25 INFO - 'MOZ_NO_REMOTE': '1', 07:51:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:25 INFO - 'NO_EM_RESTART': '1', 07:51:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:25 INFO - 'PWD': '/builds/slave/test', 07:51:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:51:25 INFO - 'SHELL': '/bin/bash', 07:51:25 INFO - 'SHLVL': '1', 07:51:25 INFO - 'TERM': 'linux', 07:51:25 INFO - 'TMOUT': '86400', 07:51:25 INFO - 'USER': 'cltbld', 07:51:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698', 07:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:25 INFO - '_': '/tools/buildbot/bin/python'} 07:51:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:51:25 INFO - mozversion application_buildid: 20161114060943 07:51:25 INFO - mozversion application_changeset: 458c900dd4ef310d5bffae1f2bb97da50839cc66 07:51:25 INFO - mozversion application_display_name: Nightly 07:51:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:51:25 INFO - mozversion application_name: Firefox 07:51:25 INFO - mozversion application_remotingname: firefox 07:51:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:51:25 INFO - mozversion application_vendor: Mozilla 07:51:25 INFO - mozversion application_version: 53.0a1 07:51:25 INFO - mozversion platform_buildid: 20161114060943 07:51:25 INFO - mozversion platform_changeset: 458c900dd4ef310d5bffae1f2bb97da50839cc66 07:51:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:51:25 INFO - mozversion platform_version: 53.0a1 07:51:25 INFO - using testdate: 1479138685 07:51:25 INFO - actual date: 1479138685 07:51:25 INFO - starting webserver on 'localhost:42280' 07:51:25 INFO - SUITE-START | Running 2 tests 07:51:25 INFO - TEST-START | dromaeo_css 07:51:25 INFO - operating with platform_type : linux_ 07:51:25 INFO - Initialising browser for dromaeo_css test... 07:51:25 INFO - TEST-INFO | started process 23760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNRPQs/profile http://localhost:42280/getInfo.html) 07:51:29 INFO - PROCESS | 23760 | __metrics Screen width/height:1600/1200 07:51:29 INFO - PROCESS | 23760 | colorDepth:24 07:51:29 INFO - PROCESS | 23760 | Browser inner width/height: 1024/697 07:51:29 INFO - PROCESS | 23760 | __metrics 07:51:30 INFO - PROCESS | 23760 | 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" 07:51:30 INFO - PROCESS | 23760 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:31 INFO - TEST-INFO | 23760: exit 0 07:51:31 INFO - Browser initialized. 07:51:31 INFO - Running cycle 1/1 for dromaeo_css test... 07:51:31 INFO - TEST-INFO | started process 23841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNRPQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:44 INFO - PROCESS | 23841 | RSS: Main: 174743552 07:51:44 INFO - PROCESS | 23841 | 07:52:35 INFO - PROCESS | 23841 | 1479138755845 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:54:49 INFO - PROCESS | 23841 | Cycle 1(1): loaded http://localhost:42280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42280/tests/dromaeo/cssquery-ext.html) 07:54:50 INFO - PROCESS | 23841 | RSS: Main: 307265536 07:54:50 INFO - PROCESS | 23841 | 07:57:53 INFO - PROCESS | 23841 | Cycle 1(1): loaded http://localhost:42280/tests/dromaeo/cssquery-ext.html (next: http://localhost:42280/tests/dromaeo/cssquery-jquery.html) 07:57:53 INFO - PROCESS | 23841 | RSS: Main: 281710592 07:57:53 INFO - PROCESS | 23841 | 08:00:56 INFO - PROCESS | 23841 | Cycle 1(1): loaded http://localhost:42280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42280/tests/dromaeo/cssquery-mootools.html) 08:00:56 INFO - PROCESS | 23841 | RSS: Main: 257515520 08:00:56 INFO - PROCESS | 23841 | 08:03:59 INFO - PROCESS | 23841 | Cycle 1(1): loaded http://localhost:42280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42280/tests/dromaeo/cssquery-prototype.html) 08:03:59 INFO - PROCESS | 23841 | RSS: Main: 220631040 08:03:59 INFO - PROCESS | 23841 | 08:07:02 INFO - PROCESS | 23841 | Cycle 1(1): loaded http://localhost:42280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42280/tests/dromaeo/cssquery-yui.html) 08:07:03 INFO - PROCESS | 23841 | RSS: Main: 221818880 08:07:03 INFO - PROCESS | 23841 | 08:10:06 INFO - PROCESS | 23841 | Cycle 1(1): loaded http://localhost:42280/tests/dromaeo/cssquery-yui.html (next: http://localhost:42280/tests/dromaeo/cssquery-dojo.html) 08:10:07 INFO - PROCESS | 23841 | RSS: Main: 301559808 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | __start_tp_report 08:10:07 INFO - PROCESS | 23841 | _x_x_mozilla_page_load 08:10:07 INFO - PROCESS | 23841 | _x_x_mozilla_page_load_details 08:10:07 INFO - PROCESS | 23841 | |i|pagename|runs| 08:10:07 INFO - PROCESS | 23841 | |0;dojo.html;2567.4479986802835;2596.636470894074;2621.8557979311136;2625.5667814810545;2634.394089359447;4533.501314855372;4627.375304333914;4653.930191047133;4667.533246675331;4687.69529980551;4645.442546894369;4652.767361631922;4700.435947686283;4730.219513780231;4735.71585704858;4232.513260974981;4262;4299.290617048183;4325.048489332342;4339.305711086226;4334.739915605058;4394;4408.382826404306;4443.200223959686;4480.19356515827;4176.749395036308;4320.243957307459;4328.264195086843;4374.190774706673;4468.240399132139;4223.13425747721;4273.850415235483;4278.4010238566625;4331.7184383015;4334.848280310205;4307.504636966758;4314.848980285707;4322.200392927287;4352.673549483801;4358.65130789536;4674.509176536449;4677.438707355105;4678.953210467886;4684.531546845323;4688.484266730657;4786.922942337947;4844.9825536637345;4846.1761500544635;4847.030593881203;4981.501849815026;5002.7248501332415;5003.299538064637;5025.572826309768;5057.873553161164;5072.391313042422;4648.907021859543;4658.510856360102;4670.509596492388;4673.976630116827;4695.178343789823;4885.902281954341;4940.555350018516;5093.414257360451;5098.923516147261;5156.587473002226;4797.376341075638;4815.036992601494;4846.39420072491;4849.975750121227;4910.8281210157475;4951.900961980812;4960.603151747924;4962.6774259673;4967.453580106186;4981.850544483671;4874.512548745097;4917.213245880714;4929.2359684248995;4931.235658472942;4977.477364876709;4743.525647435298;4862.100511405401;4862.878428039327;4919.901601968012;4922.876928076755;4225.809838557272;4228.8308467660945;4234.513031001413;4235.7670328131635;4236.110416812504;3669.9266014680093;3738.85044598213;3741.2330472253125;3750.587435382106;3751.6060813614176;4331.545187755303;4338.240807858612;4354.477462704495;4373.1472362888935;4374.846880359172;5044.899102017939;5091.643584949018;5094;5096.821611243588;5124.180131179068;4145.440365550612;4193.077522944947;4330.133973205371;4331.826726930951;4363.890902727394;4466.173757854807;4540.931886021713;4544.068465964469;4557.5442455754155;4598.724076555417;4703.31801888731;4707.223308154116;4707.7175369477945;4710.152172608963;4750.216214324598;4853.102176097434;5045.268436076675;5058.367704036996;5060.038592667529;5106.872328191676;4583.129205450954;4631.467381251199;4636.119137364025;4663.417072865892;4689.648276379217;4874.6344024197615;4905.23968784839;4912.926306105483;4915.3855768029;4938.9090511912345;5043.84868453947;5044.293798868235;5045.495450454925;5048.570871475966;5082;4720.598749106364;4785.066911952136;4802.567768900815;4809.735464549343;4940.061388336205;4855.635827313036;4856.174450343379;4856.73287969151;4856.78144483492;4892.290617860319;4777.9044419112115;4803.087413391444;4806.711597304173;4810.63920205979;4857.489963553918;4790.880227994328;4850.975745121252;4856.174450343379;4877.146499362669;4905.26421036833;4758.762061896822;4770.880727981689;4779.426468823764;4787.640926930424;4788.569028787426 08:10:07 INFO - PROCESS | 23841 | |1;ext.html;552.1662289942187;561.4273441090087;571.7684337843175;575.9308882934049;586.5688718791685;28255.576166357496;30765.69234307659;39489.605103948954;40627.796861015726;40705.796471017675;39127;39401.40897886527;39520.80239598805;39583.40624890629;39588.01029974245;7550.924490755091;7703.499272547267;7708.421868359867;7709.267619576131;7710.190430004853;7567.356774674159;7653.693852245903;7654.081510218782;7655.119661238945;7657.923420765776;7640.808979775522;7698.153203147649;7700.345470635003;7702.4993375430695;7707.036620422447;7648.923510764905;7708.6916523339;7708.768736937901;7708.997830282084;7714.768556943301;7528.849423011564;7599.468037237396;7601.467897247195;7603.581803000833;7608.201138880393;37831.810840945895;37982.62017379846;38083.61916380856;38120.42819357684;38192.80903595464;3019;3025.909222723322;3028.8939887104066;3084.2906131589634;3258.446064169097;27961.720382796117;28020.859895700392;28060;28580.285492862637;29344.26639334034;3408.7102596279346;3444.4488881778793;3504.106452854531;3514.61339252682;3545.7517973741847;174676;176308;176383.99999999872;176473;176544;52145.47854521482;52663;52709;52803;52806.735966319924;32444;33632.32735345279;33707.32585348279;55382;55507;14494.420223190955;14914.328855201542;14930.925345373204;14940.32768525419;14945;11469.31184128955;11494.42527873603;11509.446224759718;11529.365884876244;11530.135239857043;18158.3644572442;18272.908635456737;18293.90853045726;18312;18337.816621833877;6918.248415754075;6979.1973922999505;7055.9294407056295;7088.113985751781;7192;762.774981380483;848.4442690038035;864.3474176996327;899.8380291547584;919.1130559010587;26505.867470662524;27671.723282766914;28139.155825325273;28190.436191276058;28298.85850570734;783.6121120045614;914.1178762494225;916.6883259691737;958.9041095890356;969.0067680627272;13602.727945441036;14400.279986000658;14444.783328250085;14669.413223471154;14669.633259168606;347035;349334;350858;351262;352407;48833;49177.75411122993;49198;49233;49392.50607493951;1016.7508960304625;1116.6705821782593;1156.3697784707354;1157.525414580035;1160.4835848047537;25866.612000819627;28618.141455756362;29053;29256.414871702873;29285.41429171362;40627.79686101551;41143.38284925669;41202.38196426996;41241.38137927873;41296.79351603223;278702;279969;280240;280557;492326;36839.44740828943;37121;37426;37673.81163094167;37913.43129852999;40971.79514102411;41289;41358.79320603378;41888;42659.360109599;35321.823390882884;35573.466398004566;35640.465393019644;35724;36007;35202.29595408026;35347;35419.645803541636;35541.46687799633;35772.28455430929;34442.48336275008;34627.826860865534;35059.474107887894;35824.163737896095;38713.80643096766;29818.8509057462;32041;32841.17897052593;32901.83549082335;32915.50626740649;24785.50428991374;25250.494990099727;25477.05565814814;25490.74509254958;25678.486430271663 08:10:07 INFO - PROCESS | 23841 | |2;jquery.html;339.35196636161265;344.65190157940475;355.22383591851803;360.50070652146775;372.08281585890774;12545.498180072798;15634.687306253869;16093.678126437464;16585.83414165858;16815.663686726257;16116.194190290467;16601.66796664066;16801.495955121336;16851.41020064295;16869.240884160212;3724.2737666155112;4744.667873248865;4934.5312195341385;4957.033378491195;4961.553460188582;4829.323894654751;4835.492273311304;4841.467438581753;4876.073546026244;4900.117978763839;4663.207254766681;4814.711117332971;4870.025994801036;4874.390701162355;4888.217885138379;4881.072596206727;4891.315215869781;4904.166291730378;4939.456659767423;4939.629527785431;4418;4419.160359531711;4424.446944131983;4553.521880202564;4815.759212039419;10283.691489255334;10472.371657700562;10480.371177729361;10481.475926203659;10482.58069677212;1688.3584237989485;1782.2158250369926;1810.837024667773;1995.2916714566265;2239.3729755668437;8203.343732501386;8273.710420135327;8652.567371631456;8689.869651955163;8923.241524470428;1653.5204790610708;1698.1169791708242;1700.6683696679152;1712.937978453367;1718.475864861217;64714;67516.6624166876;67811;69190.46476281885;69222.65388673075;8743.781405464913;8825.823483530294;9147.542622868963;9293.442393456278;9381.202597779129;11996.100292477924;12079.637610871689;12186.756264874653;12517.624471265695;12563.246205227715;6626.635535045619;6871.209810871714;6931.504658323;6996.475264355194;7003.92996070043;6724.562903411361;6940.093827184579;6991.19601245853;7075.080239568926;7309.5248808827255;3950.6246906543834;4030.7783071931326;4034.570614977246;4046.5144182698264;4179.707420480598;1688.5694147992183;1689.6113893804247;1695.9576010599833;1717.6650553142267;1775.254393154878;834.9980023971259;839.8362319347791;873.401719821924;905.3888625177979;939.9013103624158;15444.92277538605;16183.838161618469;16367.91816040912;16392.590185245463;17082.402115925885;805.2350267246139;826.3678286111129;838.89266168658;895.6551727584927;915.7115508614766;8867.645294188289;9476.526173691425;9514.33399662017;9527.761805954906;9606.807863842683;329719;331469;336482;337067;337670;74983;75442.62278688571;77975.61012194902;78140;79011;874.3136637739344;882.4220135811054;905.8097799462187;906.9909300906907;911.6626848066257;14417.855821441652;14450.349734262194;14621.488247911271;14783.704325913206;15263.694726105638;35899;36288.27423451569;36315;36558;36721.81639091788;40832;44145.55854441415;48905.266421003005;52309.47690523198;52322.303309007904;4552.453705555222;4956.008798240294;7058.25888281723;7465.4027677786735;7681.8463630725955;8195.631196596049;11327.52742143549;11994.400279986141;12164.817527736914;12173.75652486963;10275.280730348804;10376.844347334947;10549.367037977747;10626.681199564026;10680.092192163442;10340.017698318648;10499.422531760827;10536.473176341306;10540.947295263475;10553.208509361675;10308.690739277834;10570.524326405177;10599.523021464207;10676.519556619816;11046.613368532062;6598.670066496752;7440.2931721486375;7440.590767507839;7567;7662.463627546018;8509.489430634181;10336.948315258376;10372.896271037494;10402.167826574007;10787.568497260336 08:10:07 INFO - PROCESS | 23841 | |3;mootools.html;1217.0081383672311;1322.4445732792226;1337.498438085718;1406.7819487979361;1663.9999999999993;5920.644761314319;6474.643894585802;6774.966125169367;6776.627285499296;6944.375006249436;6852.82867928302;6903.344182302686;6910.308969103087;6916.377526022657;6916.412104971084;2058.9588208235828;2086.415803574994;2087.9060442280056;2089.2583132987725;2089.44629673136;2023.9291624793136;2048.549319149785;2054.7158026233606;2088.498760297525;2099.055425058722;2026.6959956006642;2031.1976769176167;2042.223954897137;2042.8263597594223;2044.5093177637334;2033.064790196504;2054.116729806183;2055.4758536573227;2056.290579749984;2059.4954236212147;2013.5167559785693;2036.195702697441;2043.0806137238153;2048.6312463756517;2049.836013118947;6632.568883022588;6704.698288577026;6713.12729345182;6793.490488213354;6860.348266914635;4095.795210239476;4272.829086836523;4275.273203555403;4275.743455392655;4281.336392859112;2619.1095027690485;2810.8032437729366;2862.728040836117;2869.253993961564;2887.9422411551864;824.11819353292;825.9669613215464;835.5989125219928;835.778518692547;862.0259107208814;8725.869111963326;8749.606267717969;8760.518171500566;8769.298456123559;8807.867881981776;3493.982530087333;3595.334863050292;3628.2743451309843;3701.444783282529;3706.6108058653454;7190.7483238086415;7200.135983681992;7202.567845929157;7204.747833825896;7207.819804504825;4197.622214000755;4202.768847713344;4205.915881682349;4208.705390622688;4211.936820947688;3469.150058235698;3569.3575156471566;3729.1609387887506;3814.828332725034;3861.227754449121;3135.278885856266;3153.4639111351125;3287;3292.983535082309;3315.1712071982006;1075;1097.4457898761075;1100.5872797700863;1108.7782443511169;1116.179607988128;787.1813314153331;803.5178892664354;835.5446281776447;836.4312267658051;838.7064527415478;4556.24821904382;4700.341952126705;4736.573708366263;4789.090072886141;4848.5636292733825;801.0707579208207;812.0985705866483;812.6546217857386;815.3803109636718;817.8895849060301;3347.1130150510135;3481.686648201674;3487.6512348764923;3510.420780571228;3575.9642403576154;7633.885491717629;7833;8001.599920004093;8035.879461808077;8126.39052071097;7973.322267607318;8022.879656805153;8037.437379383387;8051.114377418479;8052.476589021695;6203.937960620427;6350.714217860207;6449.516286278548;6488.610683359014;6489.091527186198;4636.258198688193;4771.141194585008;4804.567588917014;4839.854804355875;4912.1894887344615;7431.925680743339;7467.58928258951;7559.811004724926;7567.091948966159;7593.05086864142;7621.733239336597;7709.421793365408;7746.690132394641;7786.182450842806;7841.137474877645;5070.340855688737;5592.356878958809;5700.144978253295;5701.4298570142655;5709.457601527848;5844.883102337844;5940.970295148497;6106.1146133811235;6424.614523128627;6499.38255865692;6099.512039036777;6100.267967843887;6106.847328816815;6112.572119951561;6218.81343559694;5839.182514447895;5890.3226128994;5912.054071348563;5928.79249226275;6032.577719559588;5654.604177707685;5718.428157184248;5780.161876527964;5780.768769249351;5791.420857914343;4254.29804082323;4261.680373971903;4379.58393952574;4414;4529.36588877564;4283.22901877665;4317.7193482423545;4345.674074444366;4469.083837813306;4472.530384309731 08:10:07 INFO - PROCESS | 23841 | |4;prototype.html;288.90610551570734;291.6704124339496;293.8912602337136;294.42733882598355;299.11909426738254;4580.29005504147;4697.718136911783;4709.128811169928;4712.85861424157;4714.387129673142;4652.651051171168;4653.255479123341;4657.55753203446;4670.719756814585;4682.29765535169;3452.4476083826594;3566.857325706969;3580;3695.464157697132;3740.6633402993793;3680.9447858282147;3684.3368193725255;3688.17016171362;3705.7220708446976;3709.3694072007825;3619.2218672985305;3642.908927276813;3667.156553992583;3678.2643471305714;3679.337719210541;3429.4684323929832;3538.4692296155526;3551.4140166872435;3664.13892735207;3675.8345874435713;3245.675432456759;3246.5454836322933;3249.7400207983305;3253.349330133959;3261.6901394367733;4487.663425243087;4505.166544189336;4510.526394728539;4515.2324104902245;4530.478994915594;4164.980389217823;4168.541460439349;4171;4173.624373806341;4192.392103145057;4564.360989461478;4793.880152996203;4799.952000480021;4806.423229212482;4817.988222473285;3463.6363181866045;3466.8093254870973;3467.427874400721;3473.7915725056578;3479.982600087009;5028.296038554606;5039.445660977326;5064.620153488503;5069.071469611007;5075.543201111917;3377.2401209727614;3537.4340105582983;3540.4689296605716;3551.0703669472787;3571.375009373401;3613.1689711366535;3627.6009638939695;3630.473581330745;3630.8547658093908;3638.1632224587966;4123.546409894909;4126.42230087788;4142.233686767958;4145.2124096422185;4159.812808423628;4889;4895.534924182197;4904.811872282973;4923.630727695438;4941.357623508993;1140.9543618255177;1190.7916114679897;1195.653260554447;1197.4671271284194;1198.5385626533673;802.2779498451324;832.4672209785742;834.4534330013851;839.366278459759;845.0324378586484;4129.463169787969;4145.709800313949;4186.748795072305;4240.915181696349;4331.7184383015;5039.269305950616;5065.721385323769;5066.3401714099655;5076.923846142311;5083.542481176638;4319.287317592625;4329.160106954531;4330.956690433055;4334.1981733379425;4347.108842687241;2537.1373732930892;2563.53856305863;2585.405356767954;2585.7802086822453;2594.2618445641465;4528.796204170821;4535.9773201133785;4567.65742569302;4590.977045114753;4611.953880461219;4940.530649588283;4955.975220123876;4971.456825639459;4981.427135879348;4986.276989836453;4495.595396414338;4575.496695363508;4598.701084429501;4771.379720636364;4799.184138696361;5048.242763585492;5049.798008079636;5063.87340316495;5066.847994560169;5070.188769796815;4995.275685025578;5003.324551185543;5022.3219865317715;5039.26930595069;5044.949550504448;4617.307403889444;4683.571510689272;4735.668503204881;4750.738709371018;4794.907284801214;3548.3435564420665;3562.786232826039;3578.82105894699;3579.498870158232;3587.7576514678326;5092;5097.796088156432;5099.311592934906;5100.821471248637;5104.41299250591;4728.17256980034;4891.192953162688;4919.819243381634;4931.865670895786;4964.950350496449;4912.855772305656;4913.41039075299;4915.3855768029;4926.802927882988;4935.358403407534;4833.468318484894;4842.661013729146;4850.83022094225;4870.172070747911;4875.585575226146;4707.940713339472;4895.485973972682;4913.764237272104;4926.753662316798;4954.331165292783;4788.497207793132;4821.95178048215;4823.864488082774;4839.709617422825;4853.733044682576 08:10:07 INFO - PROCESS | 23841 | |5;yui.html;624.3226099681845;628.4626644219192;655.1515787055762;687.268059516615;721.7618185998621;11590.304581725091;12159.392030398489;12574.434150463228;12594.433250503727;12598;11392.487338069786;11450.255733377346;11465.484053217604;11467.541298348056;11469.025132863717;606.9696515174246;628.4815027602224;743.2901578992049;763.728876248932;767.098659075584;774.4037091439588;783.3537331701341;783.3693876429472;783.4320117914494;784.019975031211;829.4857188543111;829.7552222094466;830.8836762853206;831.3017065664841;831.4844796226348;643.8486955565438;661.0381894343718;798.6006996501749;821.0270829067574;822.1367564057746;602.539057620916;604.9092636104575;605.8848818724429;606.4966078155121;606.8543549548077;12279.38603069843;12297.815532767016;12333.383330833423;12337.321447320484;12364.505419783198;11857.939244581778;11976.760464790743;12158.696032599168;12299.200551964183;12567;10641.680749577525;10872.782544349147;10973.122150227962;11152.776944461066;11303.265287756352;3904.941425878614;3948.940765888514;4000.959990400117;4025.4364388985273;4040.474738284004;50400.24399634008;50453.74773126111;51048.489515104746;52316.73841630767;52442.213366799144;9151.450912945245;9415.6704515343;9453.669121580711;9484.952575237217;9679.177269931994;16719.83280167207;17910.373136940143;17911.193996270198;17936.282548698167;17936.55158621019;6231.065340199007;6441.0982462455295;6647.069410282565;6669.933300666931;6790.93209067903;3562.7327950403824;3582.194006348551;3585.085803120188;3645.854165833337;3739.626037396293;2705.810593258453;2770.709075547079;2788.986055069752;2795.4968105741164;2799.958000629992;475.3535192138689;475.4342332624166;484.367899890639;485.7255650557424;495.25958691755335;521.8956208758264;597.6384287505996;609.1958614628736;610.1762620462429;613.622622087422;7422.6288685565505;7543.73596924116;7796.766097017098;7954.403419743542;8032.518048916967;505.23709199109607;544.7031367904501;565.1861319699619;578.3695771608966;580.1674596953385;3662.7436079474714;3716.3682174030478;3760.6427389397963;3828.502294701671;3833.3483307837732;41531.377029344585;41546.37680434796;41710.1657966845;41878.162436751096;58310.708446458346;38610;42683.786581067514;44677.55322446799;58561.41438585645;65551.34448655452;55167;55638.721806390706;56452;56945.43054569484;57368.426315737146;7177.856442871218;7205.207427183111;7317.707291708485;7333.266673332624;7611.4291428142005;38191.80904095462;38834.80582597069;39517.40723889087;39942;39959.400608990305;53015.46984530105;53237.467625323254;53953;54102.72948635231;54376.45623543714;9478.620855165716;9748.415095094317;9753.414795112316;9858.802823943624;9886.110250077527;10724.51739671701;11072.335659860435;11380.886191138314;11779;11863.110266729856;10458.372497650165;10560.947195264282;10876.238663293494;10963.780724385308;11156.665300041012;10250.231232657432;10474.319169253975;10492.895071049192;10506;10585.89414105849;10476.214283928888;10713.892861071601;10902.890971090188;11188.608398706006;11209.663710088711;8987.146221108984;9001.454265596094;9094;9182.908170918472;9231.723048308562;8820.162084601952;9041.740679374556;9197.770055748391;9547.618095276111;9667.42305346998 08:10:07 INFO - PROCESS | 23841 | __end_tp_report 08:10:07 INFO - PROCESS | 23841 | __start_cc_report 08:10:07 INFO - PROCESS | 23841 | _x_x_mozilla_cycle_collect,1488 08:10:07 INFO - PROCESS | 23841 | __end_cc_report 08:10:07 INFO - PROCESS | 23841 | __startTimestamp1479139807096__endTimestamp 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | ------- Summary: start ------- 08:10:07 INFO - PROCESS | 23841 | Number of tests: 6 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | [#0] dojo.html Cycles:165 Average:4610.72 Median:4720.60 stddev:471.43 (10.0%) stddev-sans-first:444.80 08:10:07 INFO - PROCESS | 23841 | Values: 2567.4 2596.6 2621.9 2625.6 2634.4 4533.5 4627.4 4653.9 4667.5 4687.7 4645.4 4652.8 4700.4 4730.2 4735.7 4232.5 4262.0 4299.3 4325.0 4339.3 4334.7 4394.0 4408.4 4443.2 4480.2 4176.7 4320.2 4328.3 4374.2 4468.2 4223.1 4273.9 4278.4 4331.7 4334.8 4307.5 4314.8 4322.2 4352.7 4358.7 4674.5 4677.4 4679.0 4684.5 4688.5 4786.9 4845.0 4846.2 4847.0 4981.5 5002.7 5003.3 5025.6 5057.9 5072.4 4648.9 4658.5 4670.5 4674.0 4695.2 4885.9 4940.6 5093.4 5098.9 5156.6 4797.4 4815.0 4846.4 4850.0 4910.8 4951.9 4960.6 4962.7 4967.5 4981.9 4874.5 4917.2 4929.2 4931.2 4977.5 4743.5 4862.1 4862.9 4919.9 4922.9 4225.8 4228.8 4234.5 4235.8 4236.1 3669.9 3738.9 3741.2 3750.6 3751.6 4331.5 4338.2 4354.5 4373.1 4374.8 5044.9 5091.6 5094.0 5096.8 5124.2 4145.4 4193.1 4330.1 4331.8 4363.9 4466.2 4540.9 4544.1 4557.5 4598.7 4703.3 4707.2 4707.7 4710.2 4750.2 4853.1 5045.3 5058.4 5060.0 5106.9 4583.1 4631.5 4636.1 4663.4 4689.6 4874.6 4905.2 4912.9 4915.4 4938.9 5043.8 5044.3 5045.5 5048.6 5082.0 4720.6 4785.1 4802.6 4809.7 4940.1 4855.6 4856.2 4856.7 4856.8 4892.3 4777.9 4803.1 4806.7 4810.6 4857.5 4790.9 4851.0 4856.2 4877.1 4905.3 4758.8 4770.9 4779.4 4787.6 4788.6 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | [#1] ext.html Cycles:180 Average:44148.00 Median:35798.22 stddev:78384.83 (219.0%) stddev-sans-first:78536.38 08:10:07 INFO - PROCESS | 23841 | Values: 552.2 561.4 571.8 575.9 586.6 28255.6 30765.7 39489.6 40627.8 40705.8 39127.0 39401.4 39520.8 39583.4 39588.0 7550.9 7703.5 7708.4 7709.3 7710.2 7567.4 7653.7 7654.1 7655.1 7657.9 7640.8 7698.2 7700.3 7702.5 7707.0 7648.9 7708.7 7708.8 7709.0 7714.8 7528.8 7599.5 7601.5 7603.6 7608.2 37831.8 37982.6 38083.6 38120.4 38192.8 3019.0 3025.9 3028.9 3084.3 3258.4 27961.7 28020.9 28060.0 28580.3 29344.3 3408.7 3444.4 3504.1 3514.6 3545.8 174676.0 176308.0 176384.0 176473.0 176544.0 52145.5 52663.0 52709.0 52803.0 52806.7 32444.0 33632.3 33707.3 55382.0 55507.0 14494.4 14914.3 14930.9 14940.3 14945.0 11469.3 11494.4 11509.4 11529.4 11530.1 18158.4 18272.9 18293.9 18312.0 18337.8 6918.2 6979.2 7055.9 7088.1 7192.0 762.8 848.4 864.3 899.8 919.1 26505.9 27671.7 28139.2 28190.4 28298.9 783.6 914.1 916.7 958.9 969.0 13602.7 14400.3 14444.8 14669.4 14669.6 347035.0 349334.0 350858.0 351262.0 352407.0 48833.0 49177.8 49198.0 49233.0 49392.5 1016.8 1116.7 1156.4 1157.5 1160.5 25866.6 28618.1 29053.0 29256.4 29285.4 40627.8 41143.4 41202.4 41241.4 41296.8 278702.0 279969.0 280240.0 280557.0 492326.0 36839.4 37121.0 37426.0 37673.8 37913.4 40971.8 41289.0 41358.8 41888.0 42659.4 35321.8 35573.5 35640.5 35724.0 36007.0 35202.3 35347.0 35419.6 35541.5 35772.3 34442.5 34627.8 35059.5 35824.2 38713.8 29818.9 32041.0 32841.2 32901.8 32915.5 24785.5 25250.5 25477.1 25490.7 25678.5 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | [#2] jquery.html Cycles:180 Average:22023.80 Median:24281.78 stddev:55678.25 (229.3%) stddev-sans-first:55810.63 08:10:07 INFO - PROCESS | 23841 | Values: 339.4 344.7 355.2 360.5 372.1 12545.5 15634.7 16093.7 16585.8 16815.7 16116.2 16601.7 16801.5 16851.4 16869.2 3724.3 4744.7 4934.5 4957.0 4961.6 4829.3 4835.5 4841.5 4876.1 4900.1 4663.2 4814.7 4870.0 4874.4 4888.2 4881.1 4891.3 4904.2 4939.5 4939.6 4418.0 4419.2 4424.4 4553.5 4815.8 10283.7 10472.4 10480.4 10481.5 10482.6 1688.4 1782.2 1810.8 1995.3 2239.4 8203.3 8273.7 8652.6 8689.9 8923.2 1653.5 1698.1 1700.7 1712.9 1718.5 64714.0 67516.7 67811.0 69190.5 69222.7 8743.8 8825.8 9147.5 9293.4 9381.2 11996.1 12079.6 12186.8 12517.6 12563.2 6626.6 6871.2 6931.5 6996.5 7003.9 6724.6 6940.1 6991.2 7075.1 7309.5 3950.6 4030.8 4034.6 4046.5 4179.7 1688.6 1689.6 1696.0 1717.7 1775.3 835.0 839.8 873.4 905.4 939.9 15444.9 16183.8 16367.9 16392.6 17082.4 805.2 826.4 838.9 895.7 915.7 8867.6 9476.5 9514.3 9527.8 9606.8 329719.0 331469.0 336482.0 337067.0 337670.0 74983.0 75442.6 77975.6 78140.0 79011.0 874.3 882.4 905.8 907.0 911.7 14417.9 14450.3 14621.5 14783.7 15263.7 35899.0 36288.3 36315.0 36558.0 36721.8 40832.0 44145.6 48905.3 52309.5 52322.3 4552.5 4956.0 7058.3 7465.4 7681.8 8195.6 11327.5 11994.4 12164.8 12173.8 10275.3 10376.8 10549.4 10626.7 10680.1 10340.0 10499.4 10536.5 10540.9 10553.2 10308.7 10570.5 10599.5 10676.5 11046.6 6598.7 7440.3 7440.6 7567.0 7662.5 8509.5 10336.9 10372.9 10402.2 10787.6 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | [#3] mootools.html Cycles:180 Average:4502.52 Median:5331.35 stddev:2348.60 (44.1%) stddev-sans-first:2342.21 08:10:07 INFO - PROCESS | 23841 | Values: 1217.0 1322.4 1337.5 1406.8 1664.0 5920.6 6474.6 6775.0 6776.6 6944.4 6852.8 6903.3 6910.3 6916.4 6916.4 2059.0 2086.4 2087.9 2089.3 2089.4 2023.9 2048.5 2054.7 2088.5 2099.1 2026.7 2031.2 2042.2 2042.8 2044.5 2033.1 2054.1 2055.5 2056.3 2059.5 2013.5 2036.2 2043.1 2048.6 2049.8 6632.6 6704.7 6713.1 6793.5 6860.3 4095.8 4272.8 4275.3 4275.7 4281.3 2619.1 2810.8 2862.7 2869.3 2887.9 824.1 826.0 835.6 835.8 862.0 8725.9 8749.6 8760.5 8769.3 8807.9 3494.0 3595.3 3628.3 3701.4 3706.6 7190.7 7200.1 7202.6 7204.7 7207.8 4197.6 4202.8 4205.9 4208.7 4211.9 3469.2 3569.4 3729.2 3814.8 3861.2 3135.3 3153.5 3287.0 3293.0 3315.2 1075.0 1097.4 1100.6 1108.8 1116.2 787.2 803.5 835.5 836.4 838.7 4556.2 4700.3 4736.6 4789.1 4848.6 801.1 812.1 812.7 815.4 817.9 3347.1 3481.7 3487.7 3510.4 3576.0 7633.9 7833.0 8001.6 8035.9 8126.4 7973.3 8022.9 8037.4 8051.1 8052.5 6203.9 6350.7 6449.5 6488.6 6489.1 4636.3 4771.1 4804.6 4839.9 4912.2 7431.9 7467.6 7559.8 7567.1 7593.1 7621.7 7709.4 7746.7 7786.2 7841.1 5070.3 5592.4 5700.1 5701.4 5709.5 5844.9 5941.0 6106.1 6424.6 6499.4 6099.5 6100.3 6106.8 6112.6 6218.8 5839.2 5890.3 5912.1 5928.8 6032.6 5654.6 5718.4 5780.2 5780.8 5791.4 4254.3 4261.7 4379.6 4414.0 4529.4 4283.2 4317.7 4345.7 4469.1 4472.5 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | [#4] prototype.html Cycles:180 Average:4049.80 Median:4577.89 stddev:1182.81 (25.8%) stddev-sans-first:1151.96 08:10:07 INFO - PROCESS | 23841 | Values: 288.9 291.7 293.9 294.4 299.1 4580.3 4697.7 4709.1 4712.9 4714.4 4652.7 4653.3 4657.6 4670.7 4682.3 3452.4 3566.9 3580.0 3695.5 3740.7 3680.9 3684.3 3688.2 3705.7 3709.4 3619.2 3642.9 3667.2 3678.3 3679.3 3429.5 3538.5 3551.4 3664.1 3675.8 3245.7 3246.5 3249.7 3253.3 3261.7 4487.7 4505.2 4510.5 4515.2 4530.5 4165.0 4168.5 4171.0 4173.6 4192.4 4564.4 4793.9 4800.0 4806.4 4818.0 3463.6 3466.8 3467.4 3473.8 3480.0 5028.3 5039.4 5064.6 5069.1 5075.5 3377.2 3537.4 3540.5 3551.1 3571.4 3613.2 3627.6 3630.5 3630.9 3638.2 4123.5 4126.4 4142.2 4145.2 4159.8 4889.0 4895.5 4904.8 4923.6 4941.4 1141.0 1190.8 1195.7 1197.5 1198.5 802.3 832.5 834.5 839.4 845.0 4129.5 4145.7 4186.7 4240.9 4331.7 5039.3 5065.7 5066.3 5076.9 5083.5 4319.3 4329.2 4331.0 4334.2 4347.1 2537.1 2563.5 2585.4 2585.8 2594.3 4528.8 4536.0 4567.7 4591.0 4612.0 4940.5 4956.0 4971.5 4981.4 4986.3 4495.6 4575.5 4598.7 4771.4 4799.2 5048.2 5049.8 5063.9 5066.8 5070.2 4995.3 5003.3 5022.3 5039.3 5044.9 4617.3 4683.6 4735.7 4750.7 4794.9 3548.3 3562.8 3578.8 3579.5 3587.8 5092.0 5097.8 5099.3 5100.8 5104.4 4728.2 4891.2 4919.8 4931.9 4965.0 4912.9 4913.4 4915.4 4926.8 4935.4 4833.5 4842.7 4850.8 4870.2 4875.6 4707.9 4895.5 4913.8 4926.8 4954.3 4788.5 4822.0 4823.9 4839.7 4853.7 08:10:07 INFO - PROCESS | 23841 | 08:10:07 INFO - PROCESS | 23841 | [#5] yui.html Cycles:180 Average:13761.18 Median:25785.19 stddev:16841.05 (65.3%) stddev-sans-first:16859.40 08:10:07 INFO - PROCESS | 23841 | Values: 624.3 628.5 655.2 687.3 721.8 11590.3 12159.4 12574.4 12594.4 12598.0 11392.5 11450.3 11465.5 11467.5 11469.0 607.0 628.5 743.3 763.7 767.1 774.4 783.4 783.4 783.4 784.0 829.5 829.8 830.9 831.3 831.5 643.8 661.0 798.6 821.0 822.1 602.5 604.9 605.9 606.5 606.9 12279.4 12297.8 12333.4 12337.3 12364.5 11857.9 11976.8 12158.7 12299.2 12567.0 10641.7 10872.8 10973.1 11152.8 11303.3 3904.9 3948.9 4001.0 4025.4 4040.5 50400.2 50453.7 51048.5 52316.7 52442.2 9151.5 9415.7 9453.7 9485.0 9679.2 16719.8 17910.4 17911.2 17936.3 17936.6 6231.1 6441.1 6647.1 6669.9 6790.9 3562.7 3582.2 3585.1 3645.9 3739.6 2705.8 2770.7 2789.0 2795.5 2800.0 475.4 475.4 484.4 485.7 495.3 521.9 597.6 609.2 610.2 613.6 7422.6 7543.7 7796.8 7954.4 8032.5 505.2 544.7 565.2 578.4 580.2 3662.7 3716.4 3760.6 3828.5 3833.3 41531.4 41546.4 41710.2 41878.2 58310.7 38610.0 42683.8 44677.6 58561.4 65551.3 55167.0 55638.7 56452.0 56945.4 57368.4 7177.9 7205.2 7317.7 7333.3 7611.4 38191.8 38834.8 39517.4 39942.0 39959.4 53015.5 53237.5 53953.0 54102.7 54376.5 9478.6 9748.4 9753.4 9858.8 9886.1 10724.5 11072.3 11380.9 11779.0 11863.1 10458.4 10560.9 10876.2 10963.8 11156.7 10250.2 10474.3 10492.9 10506.0 10585.9 10476.2 10713.9 10902.9 11188.6 11209.7 8987.1 9001.5 9094.0 9182.9 9231.7 8820.2 9041.7 9197.8 9547.6 9667.4 08:10:07 INFO - PROCESS | 23841 | -------- Summary: end -------- 08:10:07 INFO - PROCESS | 23841 | 08:10:08 INFO - TEST-INFO | 23841: exit 0 08:10:08 INFO - TEST-OK | dromaeo_css | took 1122800ms 08:10:08 INFO - TEST-START | kraken 08:10:08 INFO - operating with platform_type : linux_ 08:10:08 INFO - Initialising browser for kraken test... 08:10:08 INFO - TEST-INFO | started process 24150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDBDlr/profile http://localhost:42280/getInfo.html) 08:10:12 INFO - PROCESS | 24150 | __metrics Screen width/height:1600/1200 08:10:12 INFO - PROCESS | 24150 | colorDepth:24 08:10:12 INFO - PROCESS | 24150 | Browser inner width/height: 1024/697 08:10:12 INFO - PROCESS | 24150 | __metrics 08:10:13 INFO - PROCESS | 24150 | 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" 08:10:13 INFO - PROCESS | 24150 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:13 INFO - PROCESS | 24150 | console.error: PushService: 08:10:13 INFO - PROCESS | 24150 | stateChangeProcessEnqueue: Error transitioning state 08:10:13 INFO - PROCESS | 24150 | UnknownError 08:10:14 INFO - TEST-INFO | 24150: exit 0 08:10:14 INFO - Browser initialized. 08:10:14 INFO - Running cycle 1/1 for kraken test... 08:10:14 INFO - TEST-INFO | started process 24230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDBDlr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:26 INFO - PROCESS | 24230 | RSS: Main: 174780416 08:10:26 INFO - PROCESS | 24230 | 08:10:29 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42280/tests/kraken/driver.html?testName=audio-beat-detection) 08:10:30 INFO - PROCESS | 24230 | RSS: Main: 236146688 08:10:30 INFO - PROCESS | 24230 | 08:10:33 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42280/tests/kraken/driver.html?testName=audio-dft) 08:10:33 INFO - PROCESS | 24230 | RSS: Main: 217874432 08:10:33 INFO - PROCESS | 24230 | 08:10:37 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42280/tests/kraken/driver.html?testName=audio-fft) 08:10:37 INFO - PROCESS | 24230 | RSS: Main: 300421120 08:10:37 INFO - PROCESS | 24230 | 08:10:40 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42280/tests/kraken/driver.html?testName=audio-oscillator) 08:10:40 INFO - PROCESS | 24230 | RSS: Main: 209027072 08:10:40 INFO - PROCESS | 24230 | 08:10:42 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:10:43 INFO - PROCESS | 24230 | RSS: Main: 214835200 08:10:43 INFO - PROCESS | 24230 | 08:10:46 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42280/tests/kraken/driver.html?testName=imaging-darkroom) 08:10:47 INFO - PROCESS | 24230 | RSS: Main: 254377984 08:10:47 INFO - PROCESS | 24230 | 08:10:50 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42280/tests/kraken/driver.html?testName=imaging-desaturate) 08:10:51 INFO - PROCESS | 24230 | RSS: Main: 253198336 08:10:51 INFO - PROCESS | 24230 | 08:10:54 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42280/tests/kraken/driver.html?testName=json-parse-financial) 08:10:54 INFO - PROCESS | 24230 | RSS: Main: 252817408 08:10:54 INFO - PROCESS | 24230 | 08:10:56 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:10:57 INFO - PROCESS | 24230 | RSS: Main: 214958080 08:10:57 INFO - PROCESS | 24230 | 08:10:58 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:10:59 INFO - PROCESS | 24230 | RSS: Main: 221581312 08:10:59 INFO - PROCESS | 24230 | 08:11:01 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:02 INFO - PROCESS | 24230 | RSS: Main: 230268928 08:11:02 INFO - PROCESS | 24230 | 08:11:05 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:06 INFO - PROCESS | 24230 | RSS: Main: 234135552 08:11:06 INFO - PROCESS | 24230 | 08:11:09 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:11:09 INFO - PROCESS | 24230 | RSS: Main: 235155456 08:11:09 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | Cycle 1(1): loaded http://localhost:42280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42280/tests/kraken/driver.html?testName=ai-astar) 08:11:11 INFO - PROCESS | 24230 | RSS: Main: 287432704 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | __start_tp_report 08:11:11 INFO - PROCESS | 24230 | _x_x_mozilla_page_load 08:11:11 INFO - PROCESS | 24230 | _x_x_mozilla_page_load_details 08:11:11 INFO - PROCESS | 24230 | |i|pagename|runs| 08:11:11 INFO - PROCESS | 24230 | |0;ai-astar;110;115;117;117;116;118;115;115;116;115 08:11:11 INFO - PROCESS | 24230 | |1;audio-beat-detection;157;129;130;174;132;129;131;127;169;130 08:11:11 INFO - PROCESS | 24230 | |2;audio-dft;162;162;161;162;160;160;160;162;163;161 08:11:11 INFO - PROCESS | 24230 | |3;audio-fft;76;75;75;103;77;77;76;77;104;75 08:11:11 INFO - PROCESS | 24230 | |4;audio-oscillator;84;83;119;83;84;84;110;84;85;115 08:11:11 INFO - PROCESS | 24230 | |5;imaging-gaussian-blur;118;117;117;116;117;117;117;117;117;117 08:11:11 INFO - PROCESS | 24230 | |6;imaging-darkroom;147;146;147;146;146;147;146;146;147;148 08:11:11 INFO - PROCESS | 24230 | |7;imaging-desaturate;84;88;85;84;85;84;84;84;84;84 08:11:11 INFO - PROCESS | 24230 | |8;json-parse-financial;64;65;63;65;63;65;66;64;64;64 08:11:11 INFO - PROCESS | 24230 | |9;json-stringify-tinderbox;66;66;66;66;66;65;66;66;66;67 08:11:11 INFO - PROCESS | 24230 | |10;stanford-crypto-aes;86;85;83;96;85;84;84;85;86;85 08:11:11 INFO - PROCESS | 24230 | |11;stanford-crypto-ccm;143;142;143;143;142;142;148;139;227;145 08:11:11 INFO - PROCESS | 24230 | |12;stanford-crypto-pbkdf2;180;180;180;182;184;181;182;187;184;178 08:11:11 INFO - PROCESS | 24230 | |13;stanford-crypto-sha256-iterative;70;69;70;70;70;69;69;68;68;68 08:11:11 INFO - PROCESS | 24230 | __end_tp_report 08:11:11 INFO - PROCESS | 24230 | __start_cc_report 08:11:11 INFO - PROCESS | 24230 | _x_x_mozilla_cycle_collect,1931 08:11:11 INFO - PROCESS | 24230 | __end_cc_report 08:11:11 INFO - PROCESS | 24230 | __startTimestamp1479139871752__endTimestamp 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | ------- Summary: start ------- 08:11:11 INFO - PROCESS | 24230 | Number of tests: 14 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:2.17 (1.9%) stddev-sans-first:1.12 08:11:11 INFO - PROCESS | 24230 | Values: 110.0 115.0 117.0 117.0 116.0 118.0 115.0 115.0 116.0 115.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:131.50 stddev:18.37 (14.0%) stddev-sans-first:18.52 08:11:11 INFO - PROCESS | 24230 | Values: 157.0 129.0 130.0 174.0 132.0 129.0 131.0 127.0 169.0 130.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 08:11:11 INFO - PROCESS | 24230 | Values: 162.0 162.0 161.0 162.0 160.0 160.0 160.0 162.0 163.0 161.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.63 (15.3%) stddev-sans-first:12.16 08:11:11 INFO - PROCESS | 24230 | Values: 76.0 75.0 75.0 103.0 77.0 77.0 76.0 77.0 104.0 75.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:15.04 (17.9%) stddev-sans-first:15.59 08:11:11 INFO - PROCESS | 24230 | Values: 84.0 83.0 119.0 83.0 84.0 84.0 110.0 84.0 85.0 115.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:11:11 INFO - PROCESS | 24230 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:11:11 INFO - PROCESS | 24230 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 148.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 08:11:11 INFO - PROCESS | 24230 | Values: 84.0 88.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 08:11:11 INFO - PROCESS | 24230 | Values: 64.0 65.0 63.0 65.0 63.0 65.0 66.0 64.0 64.0 64.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 08:11:11 INFO - PROCESS | 24230 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 67.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.67 (4.3%) stddev-sans-first:3.89 08:11:11 INFO - PROCESS | 24230 | Values: 86.0 85.0 83.0 96.0 85.0 84.0 84.0 85.0 86.0 85.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:143.00 stddev:26.66 (18.6%) stddev-sans-first:28.11 08:11:11 INFO - PROCESS | 24230 | Values: 143.0 142.0 143.0 143.0 142.0 142.0 148.0 139.0 227.0 145.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:182.00 stddev:2.62 (1.4%) stddev-sans-first:2.69 08:11:11 INFO - PROCESS | 24230 | Values: 180.0 180.0 180.0 182.0 184.0 181.0 182.0 187.0 184.0 178.0 08:11:11 INFO - PROCESS | 24230 | 08:11:11 INFO - PROCESS | 24230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:11:11 INFO - PROCESS | 24230 | Values: 70.0 69.0 70.0 70.0 70.0 69.0 69.0 68.0 68.0 68.0 08:11:11 INFO - PROCESS | 24230 | -------- Summary: end -------- 08:11:11 INFO - PROCESS | 24230 | 08:11:13 INFO - TEST-INFO | 24230: exit 0 08:11:13 INFO - TEST-OK | kraken | took 64992ms 08:11:13 INFO - SUITE-END | took 1187s 08:11:13 INFO - Completed test suite (00:19:48) 08:11:13 INFO - javascript benchmark 08:11:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.4479986802835, 2596.636470894074, 2621.8557979311136, 2625.5667814810545, 2634.394089359447, 4533.501314855372, 4627.375304333914, 4653.930191047133, 4667.533246675331, 4687.69529980551, 4645.442546894369, 4652.767361631922, 4700.435947686283, 4730.219513780231, 4735.71585704858, 4232.513260974981, 4262.0, 4299.290617048183, 4325.048489332342, 4339.305711086226, 4334.739915605058, 4394.0, 4408.382826404306, 4443.200223959686, 4480.19356515827, 4176.749395036308, 4320.243957307459, 4328.264195086843, 4374.190774706673, 4468.240399132139, 4223.13425747721, 4273.850415235483, 4278.4010238566625, 4331.7184383015, 4334.848280310205, 4307.504636966758, 4314.848980285707, 4322.200392927287, 4352.673549483801, 4358.65130789536, 4674.509176536449, 4677.438707355105, 4678.953210467886, 4684.531546845323, 4688.484266730657, 4786.922942337947, 4844.9825536637345, 4846.1761500544635, 4847.030593881203, 4981.501849815026, 5002.7248501332415, 5003.299538064637, 5025.572826309768, 5057.873553161164, 5072.391313042422, 4648.907021859543, 4658.510856360102, 4670.509596492388, 4673.976630116827, 4695.178343789823, 4885.902281954341, 4940.555350018516, 5093.414257360451, 5098.923516147261, 5156.587473002226, 4797.376341075638, 4815.036992601494, 4846.39420072491, 4849.975750121227, 4910.8281210157475, 4951.900961980812, 4960.603151747924, 4962.6774259673, 4967.453580106186, 4981.850544483671, 4874.512548745097, 4917.213245880714, 4929.2359684248995, 4931.235658472942, 4977.477364876709, 4743.525647435298, 4862.100511405401, 4862.878428039327, 4919.901601968012, 4922.876928076755, 4225.809838557272, 4228.8308467660945, 4234.513031001413, 4235.7670328131635, 4236.110416812504, 3669.9266014680093, 3738.85044598213, 3741.2330472253125, 3750.587435382106, 3751.6060813614176, 4331.545187755303, 4338.240807858612, 4354.477462704495, 4373.1472362888935, 4374.846880359172, 5044.899102017939, 5091.643584949018, 5094.0, 5096.821611243588, 5124.180131179068, 4145.440365550612, 4193.077522944947, 4330.133973205371, 4331.826726930951, 4363.890902727394, 4466.173757854807, 4540.931886021713, 4544.068465964469, 4557.5442455754155, 4598.724076555417, 4703.31801888731, 4707.223308154116, 4707.7175369477945, 4710.152172608963, 4750.216214324598, 4853.102176097434, 5045.268436076675, 5058.367704036996, 5060.038592667529, 5106.872328191676, 4583.129205450954, 4631.467381251199, 4636.119137364025, 4663.417072865892, 4689.648276379217, 4874.6344024197615, 4905.23968784839, 4912.926306105483, 4915.3855768029, 4938.9090511912345, 5043.84868453947, 5044.293798868235, 5045.495450454925, 5048.570871475966, 5082.0, 4720.598749106364, 4785.066911952136, 4802.567768900815, 4809.735464549343, 4940.061388336205, 4855.635827313036, 4856.174450343379, 4856.73287969151, 4856.78144483492, 4892.290617860319, 4777.9044419112115, 4803.087413391444, 4806.711597304173, 4810.63920205979, 4857.489963553918, 4790.880227994328, 4850.975745121252, 4856.174450343379, 4877.146499362669, 4905.26421036833, 4758.762061896822, 4770.880727981689, 4779.426468823764, 4787.640926930424, 4788.569028787426], "value": 4581.152211207191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.1662289942187, 561.4273441090087, 571.7684337843175, 575.9308882934049, 586.5688718791685, 28255.576166357496, 30765.69234307659, 39489.605103948954, 40627.796861015726, 40705.796471017675, 39127.0, 39401.40897886527, 39520.80239598805, 39583.40624890629, 39588.01029974245, 7550.924490755091, 7703.499272547267, 7708.421868359867, 7709.267619576131, 7710.190430004853, 7567.356774674159, 7653.693852245903, 7654.081510218782, 7655.119661238945, 7657.923420765776, 7640.808979775522, 7698.153203147649, 7700.345470635003, 7702.4993375430695, 7707.036620422447, 7648.923510764905, 7708.6916523339, 7708.768736937901, 7708.997830282084, 7714.768556943301, 7528.849423011564, 7599.468037237396, 7601.467897247195, 7603.581803000833, 7608.201138880393, 37831.810840945895, 37982.62017379846, 38083.61916380856, 38120.42819357684, 38192.80903595464, 3019.0, 3025.909222723322, 3028.8939887104066, 3084.2906131589634, 3258.446064169097, 27961.720382796117, 28020.859895700392, 28060.0, 28580.285492862637, 29344.26639334034, 3408.7102596279346, 3444.4488881778793, 3504.106452854531, 3514.61339252682, 3545.7517973741847, 174676.0, 176308.0, 176383.99999999872, 176473.0, 176544.0, 52145.47854521482, 52663.0, 52709.0, 52803.0, 52806.735966319924, 32444.0, 33632.32735345279, 33707.32585348279, 55382.0, 55507.0, 14494.420223190955, 14914.328855201542, 14930.925345373204, 14940.32768525419, 14945.0, 11469.31184128955, 11494.42527873603, 11509.446224759718, 11529.365884876244, 11530.135239857043, 18158.3644572442, 18272.908635456737, 18293.90853045726, 18312.0, 18337.816621833877, 6918.248415754075, 6979.1973922999505, 7055.9294407056295, 7088.113985751781, 7192.0, 762.774981380483, 848.4442690038035, 864.3474176996327, 899.8380291547584, 919.1130559010587, 26505.867470662524, 27671.723282766914, 28139.155825325273, 28190.436191276058, 28298.85850570734, 783.6121120045614, 914.1178762494225, 916.6883259691737, 958.9041095890356, 969.0067680627272, 13602.727945441036, 14400.279986000658, 14444.783328250085, 14669.413223471154, 14669.633259168606, 347035.0, 349334.0, 350858.0, 351262.0, 352407.0, 48833.0, 49177.75411122993, 49198.0, 49233.0, 49392.50607493951, 1016.7508960304625, 1116.6705821782593, 1156.3697784707354, 1157.525414580035, 1160.4835848047537, 25866.612000819627, 28618.141455756362, 29053.0, 29256.414871702873, 29285.41429171362, 40627.79686101551, 41143.38284925669, 41202.38196426996, 41241.38137927873, 41296.79351603223, 278702.0, 279969.0, 280240.0, 280557.0, 492326.0, 36839.44740828943, 37121.0, 37426.0, 37673.81163094167, 37913.43129852999, 40971.79514102411, 41289.0, 41358.79320603378, 41888.0, 42659.360109599, 35321.823390882884, 35573.466398004566, 35640.465393019644, 35724.0, 36007.0, 35202.29595408026, 35347.0, 35419.645803541636, 35541.46687799633, 35772.28455430929, 34442.48336275008, 34627.826860865534, 35059.474107887894, 35824.163737896095, 38713.80643096766, 29818.8509057462, 32041.0, 32841.17897052593, 32901.83549082335, 32915.50626740649, 24785.50428991374, 25250.494990099727, 25477.05565814814, 25490.74509254958, 25678.486430271663], "value": 17157.50786205556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.35196636161265, 344.65190157940475, 355.22383591851803, 360.50070652146775, 372.08281585890774, 12545.498180072798, 15634.687306253869, 16093.678126437464, 16585.83414165858, 16815.663686726257, 16116.194190290467, 16601.66796664066, 16801.495955121336, 16851.41020064295, 16869.240884160212, 3724.2737666155112, 4744.667873248865, 4934.5312195341385, 4957.033378491195, 4961.553460188582, 4829.323894654751, 4835.492273311304, 4841.467438581753, 4876.073546026244, 4900.117978763839, 4663.207254766681, 4814.711117332971, 4870.025994801036, 4874.390701162355, 4888.217885138379, 4881.072596206727, 4891.315215869781, 4904.166291730378, 4939.456659767423, 4939.629527785431, 4418.0, 4419.160359531711, 4424.446944131983, 4553.521880202564, 4815.759212039419, 10283.691489255334, 10472.371657700562, 10480.371177729361, 10481.475926203659, 10482.58069677212, 1688.3584237989485, 1782.2158250369926, 1810.837024667773, 1995.2916714566265, 2239.3729755668437, 8203.343732501386, 8273.710420135327, 8652.567371631456, 8689.869651955163, 8923.241524470428, 1653.5204790610708, 1698.1169791708242, 1700.6683696679152, 1712.937978453367, 1718.475864861217, 64714.0, 67516.6624166876, 67811.0, 69190.46476281885, 69222.65388673075, 8743.781405464913, 8825.823483530294, 9147.542622868963, 9293.442393456278, 9381.202597779129, 11996.100292477924, 12079.637610871689, 12186.756264874653, 12517.624471265695, 12563.246205227715, 6626.635535045619, 6871.209810871714, 6931.504658323, 6996.475264355194, 7003.92996070043, 6724.562903411361, 6940.093827184579, 6991.19601245853, 7075.080239568926, 7309.5248808827255, 3950.6246906543834, 4030.7783071931326, 4034.570614977246, 4046.5144182698264, 4179.707420480598, 1688.5694147992183, 1689.6113893804247, 1695.9576010599833, 1717.6650553142267, 1775.254393154878, 834.9980023971259, 839.8362319347791, 873.401719821924, 905.3888625177979, 939.9013103624158, 15444.92277538605, 16183.838161618469, 16367.91816040912, 16392.590185245463, 17082.402115925885, 805.2350267246139, 826.3678286111129, 838.89266168658, 895.6551727584927, 915.7115508614766, 8867.645294188289, 9476.526173691425, 9514.33399662017, 9527.761805954906, 9606.807863842683, 329719.0, 331469.0, 336482.0, 337067.0, 337670.0, 74983.0, 75442.62278688571, 77975.61012194902, 78140.0, 79011.0, 874.3136637739344, 882.4220135811054, 905.8097799462187, 906.9909300906907, 911.6626848066257, 14417.855821441652, 14450.349734262194, 14621.488247911271, 14783.704325913206, 15263.694726105638, 35899.0, 36288.27423451569, 36315.0, 36558.0, 36721.81639091788, 40832.0, 44145.55854441415, 48905.266421003005, 52309.47690523198, 52322.303309007904, 4552.453705555222, 4956.008798240294, 7058.25888281723, 7465.4027677786735, 7681.8463630725955, 8195.631196596049, 11327.52742143549, 11994.400279986141, 12164.817527736914, 12173.75652486963, 10275.280730348804, 10376.844347334947, 10549.367037977747, 10626.681199564026, 10680.092192163442, 10340.017698318648, 10499.422531760827, 10536.473176341306, 10540.947295263475, 10553.208509361675, 10308.690739277834, 10570.524326405177, 10599.523021464207, 10676.519556619816, 11046.613368532062, 6598.670066496752, 7440.2931721486375, 7440.590767507839, 7567.0, 7662.463627546018, 8509.489430634181, 10336.948315258376, 10372.896271037494, 10402.167826574007, 10787.568497260336], "value": 7660.371565949993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.0081383672311, 1322.4445732792226, 1337.498438085718, 1406.7819487979361, 1663.9999999999993, 5920.644761314319, 6474.643894585802, 6774.966125169367, 6776.627285499296, 6944.375006249436, 6852.82867928302, 6903.344182302686, 6910.308969103087, 6916.377526022657, 6916.412104971084, 2058.9588208235828, 2086.415803574994, 2087.9060442280056, 2089.2583132987725, 2089.44629673136, 2023.9291624793136, 2048.549319149785, 2054.7158026233606, 2088.498760297525, 2099.055425058722, 2026.6959956006642, 2031.1976769176167, 2042.223954897137, 2042.8263597594223, 2044.5093177637334, 2033.064790196504, 2054.116729806183, 2055.4758536573227, 2056.290579749984, 2059.4954236212147, 2013.5167559785693, 2036.195702697441, 2043.0806137238153, 2048.6312463756517, 2049.836013118947, 6632.568883022588, 6704.698288577026, 6713.12729345182, 6793.490488213354, 6860.348266914635, 4095.795210239476, 4272.829086836523, 4275.273203555403, 4275.743455392655, 4281.336392859112, 2619.1095027690485, 2810.8032437729366, 2862.728040836117, 2869.253993961564, 2887.9422411551864, 824.11819353292, 825.9669613215464, 835.5989125219928, 835.778518692547, 862.0259107208814, 8725.869111963326, 8749.606267717969, 8760.518171500566, 8769.298456123559, 8807.867881981776, 3493.982530087333, 3595.334863050292, 3628.2743451309843, 3701.444783282529, 3706.6108058653454, 7190.7483238086415, 7200.135983681992, 7202.567845929157, 7204.747833825896, 7207.819804504825, 4197.622214000755, 4202.768847713344, 4205.915881682349, 4208.705390622688, 4211.936820947688, 3469.150058235698, 3569.3575156471566, 3729.1609387887506, 3814.828332725034, 3861.227754449121, 3135.278885856266, 3153.4639111351125, 3287.0, 3292.983535082309, 3315.1712071982006, 1075.0, 1097.4457898761075, 1100.5872797700863, 1108.7782443511169, 1116.179607988128, 787.1813314153331, 803.5178892664354, 835.5446281776447, 836.4312267658051, 838.7064527415478, 4556.24821904382, 4700.341952126705, 4736.573708366263, 4789.090072886141, 4848.5636292733825, 801.0707579208207, 812.0985705866483, 812.6546217857386, 815.3803109636718, 817.8895849060301, 3347.1130150510135, 3481.686648201674, 3487.6512348764923, 3510.420780571228, 3575.9642403576154, 7633.885491717629, 7833.0, 8001.599920004093, 8035.879461808077, 8126.39052071097, 7973.322267607318, 8022.879656805153, 8037.437379383387, 8051.114377418479, 8052.476589021695, 6203.937960620427, 6350.714217860207, 6449.516286278548, 6488.610683359014, 6489.091527186198, 4636.258198688193, 4771.141194585008, 4804.567588917014, 4839.854804355875, 4912.1894887344615, 7431.925680743339, 7467.58928258951, 7559.811004724926, 7567.091948966159, 7593.05086864142, 7621.733239336597, 7709.421793365408, 7746.690132394641, 7786.182450842806, 7841.137474877645, 5070.340855688737, 5592.356878958809, 5700.144978253295, 5701.4298570142655, 5709.457601527848, 5844.883102337844, 5940.970295148497, 6106.1146133811235, 6424.614523128627, 6499.38255865692, 6099.512039036777, 6100.267967843887, 6106.847328816815, 6112.572119951561, 6218.81343559694, 5839.182514447895, 5890.3226128994, 5912.054071348563, 5928.79249226275, 6032.577719559588, 5654.604177707685, 5718.428157184248, 5780.161876527964, 5780.768769249351, 5791.420857914343, 4254.29804082323, 4261.680373971903, 4379.58393952574, 4414.0, 4529.36588877564, 4283.22901877665, 4317.7193482423545, 4345.674074444366, 4469.083837813306, 4472.530384309731], "value": 3716.148872805345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.90610551570734, 291.6704124339496, 293.8912602337136, 294.42733882598355, 299.11909426738254, 4580.29005504147, 4697.718136911783, 4709.128811169928, 4712.85861424157, 4714.387129673142, 4652.651051171168, 4653.255479123341, 4657.55753203446, 4670.719756814585, 4682.29765535169, 3452.4476083826594, 3566.857325706969, 3580.0, 3695.464157697132, 3740.6633402993793, 3680.9447858282147, 3684.3368193725255, 3688.17016171362, 3705.7220708446976, 3709.3694072007825, 3619.2218672985305, 3642.908927276813, 3667.156553992583, 3678.2643471305714, 3679.337719210541, 3429.4684323929832, 3538.4692296155526, 3551.4140166872435, 3664.13892735207, 3675.8345874435713, 3245.675432456759, 3246.5454836322933, 3249.7400207983305, 3253.349330133959, 3261.6901394367733, 4487.663425243087, 4505.166544189336, 4510.526394728539, 4515.2324104902245, 4530.478994915594, 4164.980389217823, 4168.541460439349, 4171.0, 4173.624373806341, 4192.392103145057, 4564.360989461478, 4793.880152996203, 4799.952000480021, 4806.423229212482, 4817.988222473285, 3463.6363181866045, 3466.8093254870973, 3467.427874400721, 3473.7915725056578, 3479.982600087009, 5028.296038554606, 5039.445660977326, 5064.620153488503, 5069.071469611007, 5075.543201111917, 3377.2401209727614, 3537.4340105582983, 3540.4689296605716, 3551.0703669472787, 3571.375009373401, 3613.1689711366535, 3627.6009638939695, 3630.473581330745, 3630.8547658093908, 3638.1632224587966, 4123.546409894909, 4126.42230087788, 4142.233686767958, 4145.2124096422185, 4159.812808423628, 4889.0, 4895.534924182197, 4904.811872282973, 4923.630727695438, 4941.357623508993, 1140.9543618255177, 1190.7916114679897, 1195.653260554447, 1197.4671271284194, 1198.5385626533673, 802.2779498451324, 832.4672209785742, 834.4534330013851, 839.366278459759, 845.0324378586484, 4129.463169787969, 4145.709800313949, 4186.748795072305, 4240.915181696349, 4331.7184383015, 5039.269305950616, 5065.721385323769, 5066.3401714099655, 5076.923846142311, 5083.542481176638, 4319.287317592625, 4329.160106954531, 4330.956690433055, 4334.1981733379425, 4347.108842687241, 2537.1373732930892, 2563.53856305863, 2585.405356767954, 2585.7802086822453, 2594.2618445641465, 4528.796204170821, 4535.9773201133785, 4567.65742569302, 4590.977045114753, 4611.953880461219, 4940.530649588283, 4955.975220123876, 4971.456825639459, 4981.427135879348, 4986.276989836453, 4495.595396414338, 4575.496695363508, 4598.701084429501, 4771.379720636364, 4799.184138696361, 5048.242763585492, 5049.798008079636, 5063.87340316495, 5066.847994560169, 5070.188769796815, 4995.275685025578, 5003.324551185543, 5022.3219865317715, 5039.26930595069, 5044.949550504448, 4617.307403889444, 4683.571510689272, 4735.668503204881, 4750.738709371018, 4794.907284801214, 3548.3435564420665, 3562.786232826039, 3578.82105894699, 3579.498870158232, 3587.7576514678326, 5092.0, 5097.796088156432, 5099.311592934906, 5100.821471248637, 5104.41299250591, 4728.17256980034, 4891.192953162688, 4919.819243381634, 4931.865670895786, 4964.950350496449, 4912.855772305656, 4913.41039075299, 4915.3855768029, 4926.802927882988, 4935.358403407534, 4833.468318484894, 4842.661013729146, 4850.83022094225, 4870.172070747911, 4875.585575226146, 4707.940713339472, 4895.485973972682, 4913.764237272104, 4926.753662316798, 4954.331165292783, 4788.497207793132, 4821.95178048215, 4823.864488082774, 4839.709617422825, 4853.733044682576], "value": 3673.072924841214, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.3226099681845, 628.4626644219192, 655.1515787055762, 687.268059516615, 721.7618185998621, 11590.304581725091, 12159.392030398489, 12574.434150463228, 12594.433250503727, 12598.0, 11392.487338069786, 11450.255733377346, 11465.484053217604, 11467.541298348056, 11469.025132863717, 606.9696515174246, 628.4815027602224, 743.2901578992049, 763.728876248932, 767.098659075584, 774.4037091439588, 783.3537331701341, 783.3693876429472, 783.4320117914494, 784.019975031211, 829.4857188543111, 829.7552222094466, 830.8836762853206, 831.3017065664841, 831.4844796226348, 643.8486955565438, 661.0381894343718, 798.6006996501749, 821.0270829067574, 822.1367564057746, 602.539057620916, 604.9092636104575, 605.8848818724429, 606.4966078155121, 606.8543549548077, 12279.38603069843, 12297.815532767016, 12333.383330833423, 12337.321447320484, 12364.505419783198, 11857.939244581778, 11976.760464790743, 12158.696032599168, 12299.200551964183, 12567.0, 10641.680749577525, 10872.782544349147, 10973.122150227962, 11152.776944461066, 11303.265287756352, 3904.941425878614, 3948.940765888514, 4000.959990400117, 4025.4364388985273, 4040.474738284004, 50400.24399634008, 50453.74773126111, 51048.489515104746, 52316.73841630767, 52442.213366799144, 9151.450912945245, 9415.6704515343, 9453.669121580711, 9484.952575237217, 9679.177269931994, 16719.83280167207, 17910.373136940143, 17911.193996270198, 17936.282548698167, 17936.55158621019, 6231.065340199007, 6441.0982462455295, 6647.069410282565, 6669.933300666931, 6790.93209067903, 3562.7327950403824, 3582.194006348551, 3585.085803120188, 3645.854165833337, 3739.626037396293, 2705.810593258453, 2770.709075547079, 2788.986055069752, 2795.4968105741164, 2799.958000629992, 475.3535192138689, 475.4342332624166, 484.367899890639, 485.7255650557424, 495.25958691755335, 521.8956208758264, 597.6384287505996, 609.1958614628736, 610.1762620462429, 613.622622087422, 7422.6288685565505, 7543.73596924116, 7796.766097017098, 7954.403419743542, 8032.518048916967, 505.23709199109607, 544.7031367904501, 565.1861319699619, 578.3695771608966, 580.1674596953385, 3662.7436079474714, 3716.3682174030478, 3760.6427389397963, 3828.502294701671, 3833.3483307837732, 41531.377029344585, 41546.37680434796, 41710.1657966845, 41878.162436751096, 58310.708446458346, 38610.0, 42683.786581067514, 44677.55322446799, 58561.41438585645, 65551.34448655452, 55167.0, 55638.721806390706, 56452.0, 56945.43054569484, 57368.426315737146, 7177.856442871218, 7205.207427183111, 7317.707291708485, 7333.266673332624, 7611.4291428142005, 38191.80904095462, 38834.80582597069, 39517.40723889087, 39942.0, 39959.400608990305, 53015.46984530105, 53237.467625323254, 53953.0, 54102.72948635231, 54376.45623543714, 9478.620855165716, 9748.415095094317, 9753.414795112316, 9858.802823943624, 9886.110250077527, 10724.51739671701, 11072.335659860435, 11380.886191138314, 11779.0, 11863.110266729856, 10458.372497650165, 10560.947195264282, 10876.238663293494, 10963.780724385308, 11156.665300041012, 10250.231232657432, 10474.319169253975, 10492.895071049192, 10506.0, 10585.89414105849, 10476.214283928888, 10713.892861071601, 10902.890971090188, 11188.608398706006, 11209.663710088711, 8987.146221108984, 9001.454265596094, 9094.0, 9182.908170918472, 9231.723048308562, 8820.162084601952, 9041.740679374556, 9197.770055748391, 9547.618095276111, 9667.42305346998], "value": 5947.498001389824, "unit": "score"}], "name": "dromaeo_css", "value": 6046.8837359849995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 117.0, 117.0, 116.0, 118.0, 115.0, 115.0, 116.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 130.0, 174.0, 132.0, 129.0, 131.0, 127.0, 169.0, 130.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 160.0, 160.0, 160.0, 162.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 103.0, 77.0, 77.0, 76.0, 77.0, 104.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 119.0, 83.0, 84.0, 84.0, 110.0, 84.0, 85.0, 115.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 65.0, 63.0, 65.0, 66.0, 64.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 96.0, 85.0, 84.0, 84.0, 85.0, 86.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 143.0, 143.0, 142.0, 142.0, 148.0, 139.0, 227.0, 145.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 180.0, 182.0, 184.0, 181.0, 182.0, 187.0, 184.0, 178.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 68.0, 68.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1558.8, "alertThreshold": 2.0}]} 08:11:13 INFO - Return code: 0 08:11:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:11:13 INFO - # TBPL SUCCESS # 08:11:13 INFO - Running post-action listener: _resource_record_post_action 08:11:13 INFO - [mozharness: 2016-11-14 16:11:13.545019Z] Finished run-tests step (success) 08:11:13 INFO - Running post-run listener: _resource_record_post_run 08:11:13 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 12288; Write bytes: 396759040; Read time: 152; Write time: 239684 08:11:13 INFO - TinderboxPrint: CPU usage
13.1% 08:11:13 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 152 08:11:13 INFO - TinderboxPrint: I/O write bytes / time
396,759,040 / 239,684 08:11:13 INFO - TinderboxPrint: CPU idle
8,350.2 (86.9%) 08:11:13 INFO - TinderboxPrint: CPU user
1,206.6 (12.6%) 08:11:13 INFO - TinderboxPrint: Swap in / out
0 / 0 08:11:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107032576; Read time: 0; Write time: 79452 08:11:13 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289726464; Read time: 136; Write time: 160232 08:11:14 INFO - Running post-run listener: _upload_blobber_files 08:11:14 INFO - Blob upload gear active. 08:11:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:11:14 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 08:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:11:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:15 INFO - (blobuploader) - INFO - Done attempting. 08:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:19 INFO - (blobuploader) - INFO - Done attempting. 08:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:20 INFO - (blobuploader) - INFO - Done attempting. 08:11:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:11:20 INFO - Return code: 0 08:11:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:11:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:11:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2d564538e4e5954f8edaab1415dfd1b99723089e4723ba26c15201c93bd04ef7fe32b3a5ec8399437ef258e92c9dc67ca91e0f073659f7e7d8cbbac28c2a151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/642b225308dc7b603c5871d285e577b989a9ed22695b42c8417053eb160437a456fb5eda137010b5769dbf45b98445b9242e376ed97c095b5a460d551c156b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed34672778dce1de0bbcf65f343d99c19460887459bd01a3b41c7a2f7d3dd67294c6a1b9fd55dfbc9581ce30c8df582de73bc58d74df56d3c2a9c613c9a69ac3"} 08:11:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:11:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:11:20 INFO - Contents: 08:11:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2d564538e4e5954f8edaab1415dfd1b99723089e4723ba26c15201c93bd04ef7fe32b3a5ec8399437ef258e92c9dc67ca91e0f073659f7e7d8cbbac28c2a151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/642b225308dc7b603c5871d285e577b989a9ed22695b42c8417053eb160437a456fb5eda137010b5769dbf45b98445b9242e376ed97c095b5a460d551c156b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed34672778dce1de0bbcf65f343d99c19460887459bd01a3b41c7a2f7d3dd67294c6a1b9fd55dfbc9581ce30c8df582de73bc58d74df56d3c2a9c613c9a69ac3"} 08:11:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:11:20 INFO - Copying logs to upload dir... 08:11:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:11:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.016538 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-14 08:11:19.792927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 08:11:19.797353) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2d564538e4e5954f8edaab1415dfd1b99723089e4723ba26c15201c93bd04ef7fe32b3a5ec8399437ef258e92c9dc67ca91e0f073659f7e7d8cbbac28c2a151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/642b225308dc7b603c5871d285e577b989a9ed22695b42c8417053eb160437a456fb5eda137010b5769dbf45b98445b9242e376ed97c095b5a460d551c156b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed34672778dce1de0bbcf65f343d99c19460887459bd01a3b41c7a2f7d3dd67294c6a1b9fd55dfbc9581ce30c8df582de73bc58d74df56d3c2a9c613c9a69ac3"} build_url:https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/Yxefk7FUTKCYs5Xq3vs84g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2d564538e4e5954f8edaab1415dfd1b99723089e4723ba26c15201c93bd04ef7fe32b3a5ec8399437ef258e92c9dc67ca91e0f073659f7e7d8cbbac28c2a151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/642b225308dc7b603c5871d285e577b989a9ed22695b42c8417053eb160437a456fb5eda137010b5769dbf45b98445b9242e376ed97c095b5a460d551c156b27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed34672778dce1de0bbcf65f343d99c19460887459bd01a3b41c7a2f7d3dd67294c6a1b9fd55dfbc9581ce30c8df582de73bc58d74df56d3c2a9c613c9a69ac3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 08:11:19.830189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 08:11:19.830826) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1479138630.340474-1404321698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 08:11:19.914059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 08:11:19.914459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 08:11:19.914879) ========= ========= Total master_lag: 0.19 =========