builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1484584241.43 results: success (0) buildid: 20170116065021 builduid: 39a7c83ed51e48f3bf0e24e23a4c23dc revision: 325b6cc5bca7a794aad8b77d9ba12303866f5b91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.425338) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.425855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.426164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.440897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.441228) ========= 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=c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-16 08:30:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2017-01-16 08:30:43 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.567132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.567653) ========= 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=c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018681 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:41.620457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 08:30:41.621266) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 325b6cc5bca7a794aad8b77d9ba12303866f5b91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 325b6cc5bca7a794aad8b77d9ba12303866f5b91 --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=c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-16 08:30:43,363 truncating revision to first 12 chars 2017-01-16 08:30:43,363 Setting DEBUG logging. 2017-01-16 08:30:43,363 attempt 1/10 2017-01-16 08:30:43,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/325b6cc5bca7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 08:30:44,539 unpacking tar archive at: mozilla-aurora-325b6cc5bca7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.492097 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 08:30:43.128684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:43.129010) ========= script_repo_revision: 325b6cc5bca7a794aad8b77d9ba12303866f5b91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:43.129417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:43.129703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 08:30:43.139382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-16 08:30:43.139733) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:30:44 INFO - MultiFileLogger online at 20170116 08:30:44 in /builds/slave/test 08:30:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:30:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:30:44 INFO - {'append_to_log': False, 08:30:44 INFO - 'base_work_dir': '/builds/slave/test', 08:30:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:30:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:30:44 INFO - 'branch': 'Mozilla-Aurora', 08:30:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:30:44 INFO - 'config_files': ('talos/linux_config.py',), 08:30:44 INFO - 'default_actions': ('clobber', 08:30:44 INFO - 'read-buildbot-config', 08:30:44 INFO - 'download-and-extract', 08:30:44 INFO - 'populate-webroot', 08:30:44 INFO - 'create-virtualenv', 08:30:44 INFO - 'install', 08:30:44 INFO - 'run-tests'), 08:30:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:30:44 INFO - 'download_minidump_stackwalk': True, 08:30:44 INFO - 'download_symbols': 'ondemand', 08:30:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:30:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:30:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:30:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:30:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:30:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:30:44 INFO - 'installer_path': 'installer.exe', 08:30:44 INFO - 'log_level': 'info', 08:30:44 INFO - 'log_name': 'talos', 08:30:44 INFO - 'log_to_console': True, 08:30:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:30:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:30:44 INFO - 'opt_config_files': (), 08:30:44 INFO - 'pip_index': False, 08:30:44 INFO - 'sps_profile': False, 08:30:44 INFO - 'sps_profile_interval': 0, 08:30:44 INFO - 'suite': 'dromaeojs', 08:30:44 INFO - 'system_bits': '32', 08:30:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:30:44 INFO - 'title': 'talos-linux64-ix-004', 08:30:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:30:44 INFO - 'use_talos_json': True, 08:30:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:30:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:30:44 INFO - 'work_dir': 'build'} 08:30:44 INFO - [mozharness: 2017-01-16 16:30:44.979933Z] Running clobber step. 08:30:44 INFO - Running pre-action listener: _resource_record_pre_action 08:30:44 INFO - Running main action method: clobber 08:30:44 INFO - rmtree: /builds/slave/test/build 08:30:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:30:46 INFO - Running post-action listener: _resource_record_post_action 08:30:46 INFO - [mozharness: 2017-01-16 16:30:46.021917Z] Finished clobber step (success) 08:30:46 INFO - [mozharness: 2017-01-16 16:30:46.022016Z] Running read-buildbot-config step. 08:30:46 INFO - Running pre-action listener: _resource_record_pre_action 08:30:46 INFO - Running main action method: read_buildbot_config 08:30:46 INFO - Using buildbot properties: 08:30:46 INFO - { 08:30:46 INFO - "project": "", 08:30:46 INFO - "product": "firefox", 08:30:46 INFO - "script_repo_revision": "production", 08:30:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:30:46 INFO - "repository": "", 08:30:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:30:46 INFO - "buildid": "20170116065021", 08:30:46 INFO - "pgo_build": "True", 08:30:46 INFO - "basedir": "/builds/slave/test", 08:30:46 INFO - "buildnumber": 1006, 08:30:46 INFO - "slavename": "talos-linux64-ix-004", 08:30:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:30:46 INFO - "platform": "ubuntu64_hw", 08:30:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:30:46 INFO - "branch": "mozilla-aurora", 08:30:46 INFO - "repo_path": "releases/mozilla-aurora", 08:30:46 INFO - "revision": "325b6cc5bca7a794aad8b77d9ba12303866f5b91", 08:30:46 INFO - "stage_platform": "linux64-pgo", 08:30:46 INFO - "builduid": "39a7c83ed51e48f3bf0e24e23a4c23dc", 08:30:46 INFO - "slavebuilddir": "test" 08:30:46 INFO - } 08:30:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:30:46 INFO - Running post-action listener: _resource_record_post_action 08:30:46 INFO - [mozharness: 2017-01-16 16:30:46.024420Z] Finished read-buildbot-config step (success) 08:30:46 INFO - [mozharness: 2017-01-16 16:30:46.024508Z] Running download-and-extract step. 08:30:46 INFO - Running pre-action listener: _resource_record_pre_action 08:30:46 INFO - Running main action method: download_and_extract 08:30:46 INFO - mkdir: /builds/slave/test/build/tests 08:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:46 INFO - trying https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:30:46 INFO - Downloading https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:30:46 INFO - Downloaded 1361 bytes. 08:30:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:30:46 INFO - Using the following test package requirements: 08:30:46 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:30:46 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:30:46 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:30:46 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'jsshell-linux-x86_64.zip'], 08:30:46 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:30:46 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:30:46 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:30:46 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:30:46 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:30:46 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:30:46 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:30:46 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:30:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:30:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:30:46 INFO - Fetch https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:30:47 INFO - Http code: 200 08:30:47 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 08:30:47 INFO - x-amz-cf-id: YZgFd8LYaGSZNRszk0qbqBf3gEptKZ-gr6LGpROkbY80kbBOEv-MSg== 08:30:47 INFO - x-amz-version-id: usCtAQiqdL1xuv78wAQz3zyWD6Mt78UB 08:30:47 INFO - Expected file size: 21949260 08:30:47 INFO - Obtained file size: 21949260 08:30:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:30:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:30:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:30:51 INFO - Fetch https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:30:52 INFO - Http code: 200 08:30:52 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:30:52 INFO - x-amz-cf-id: pDftwEkXveH8gORTZQHsz3SdDWbyn8BT5WJkqwFcERV1I452v3DFrQ== 08:30:52 INFO - x-amz-version-id: usCtAQiqdL1xuv78wAQz3zyWD6Mt78UB 08:30:52 INFO - Expected file size: 21949260 08:30:52 INFO - Obtained file size: 21949260 08:30:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:30:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:30:56 INFO - Fetch https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:30:57 INFO - Http code: 200 08:30:57 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 08:30:57 INFO - x-amz-cf-id: FVUS0ph0qVSHWmoHEfTieeBPPx8xLOltWi_DJjnMJZ6bfhCjQFfjog== 08:30:57 INFO - x-amz-version-id: .oVx7vYCcxxDw_OXJl06qsaAertnf0WK 08:30:57 INFO - Expected file size: 14409038 08:30:57 INFO - Obtained file size: 14409038 08:30: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')]} 08:30:57 INFO - trying https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:30:57 INFO - Downloading https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:30:58 INFO - Downloaded 64169629 bytes. 08:30:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:30:58 INFO - mkdir: /builds/slave/test/properties 08:30:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:30:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:30:58 INFO - Contents: 08:30:58 INFO - build_url:https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:30:59 INFO - Running post-action listener: _resource_record_post_action 08:30:59 INFO - Running post-action listener: set_extra_try_arguments 08:30:59 INFO - [mozharness: 2017-01-16 16:30:59.429703Z] Finished download-and-extract step (success) 08:30:59 INFO - [mozharness: 2017-01-16 16:30:59.429930Z] Running populate-webroot step. 08:30:59 INFO - Running pre-action listener: _resource_record_pre_action 08:30:59 INFO - Running main action method: populate_webroot 08:30:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:30:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:30:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:30:59 INFO - '--tppagecycles', 08:30:59 INFO - '7'], 08:30:59 INFO - 'tests': ['tsvgm']}}, 08:30:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:30:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:30:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:30:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:30:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['damp', 'tps']}, 08:30:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'tests': ['damp', 'tps']}, 08:30:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['dromaeo_dom']}, 08:30:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:30:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['basic_compositor_video']}, 08:30:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:30:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['a11yr', 08:30:59 INFO - 'ts_paint', 08:30:59 INFO - 'tpaint', 08:30:59 INFO - 'sessionrestore', 08:30:59 INFO - 'sessionrestore_no_auto_restore', 08:30:59 INFO - 'tabpaint']}, 08:30:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:30:59 INFO - 'ts_paint', 08:30:59 INFO - 'tpaint', 08:30:59 INFO - 'sessionrestore', 08:30:59 INFO - 'sessionrestore_no_auto_restore', 08:30:59 INFO - 'tabpaint']}, 08:30:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:30:59 INFO - 'ts_paint', 08:30:59 INFO - 'tpaint', 08:30:59 INFO - 'sessionrestore', 08:30:59 INFO - 'sessionrestore_no_auto_restore', 08:30:59 INFO - 'tabpaint']}, 08:30:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:30:59 INFO - 'ts_paint', 08:30:59 INFO - 'tpaint', 08:30:59 INFO - 'sessionrestore', 08:30:59 INFO - 'sessionrestore_no_auto_restore', 08:30:59 INFO - 'tabpaint']}, 08:30:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['a11yr', 08:30:59 INFO - 'ts_paint', 08:30:59 INFO - 'tpaint', 08:30:59 INFO - 'sessionrestore', 08:30:59 INFO - 'sessionrestore_no_auto_restore', 08:30:59 INFO - 'tabpaint']}, 08:30:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['a11yr', 08:30:59 INFO - 'ts_paint', 08:30:59 INFO - 'tpaint', 08:30:59 INFO - 'sessionrestore', 08:30:59 INFO - 'sessionrestore_no_auto_restore', 08:30:59 INFO - 'tabpaint']}, 08:30:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['tsvgx', 08:30:59 INFO - 'tsvgr_opacity', 08:30:59 INFO - 'tart', 08:30:59 INFO - 'tscrollx', 08:30:59 INFO - 'cart']}, 08:30:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:30:59 INFO - 'tsvgr_opacity', 08:30:59 INFO - 'tart', 08:30:59 INFO - 'tscrollx', 08:30:59 INFO - 'cart']}, 08:30:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'talos_options': ['--disable-e10s'], 08:30:59 INFO - 'tests': ['tp5o']}, 08:30:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'tests': ['tp5o']}, 08:30:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'talos_options': ['--disable-e10s', 08:30:59 INFO - '--xperf_path', 08:30:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:59 INFO - 'tests': ['tp5n']}, 08:30:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:59 INFO - 'talos_options': ['--xperf_path', 08:30:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:59 INFO - 'tests': ['tp5n']}}, 08:30:59 INFO - 'talos.zip': {'path': '', 08:30:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:30:59 INFO - Running post-action listener: _resource_record_post_action 08:30:59 INFO - [mozharness: 2017-01-16 16:30:59.447496Z] Finished populate-webroot step (success) 08:30:59 INFO - [mozharness: 2017-01-16 16:30:59.447584Z] Running create-virtualenv step. 08:30:59 INFO - Running pre-action listener: _resource_record_pre_action 08:30:59 INFO - Running main action method: create_virtualenv 08:30:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:30:59 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 08:30:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:30:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:30:59 INFO - Using real prefix '/usr' 08:30:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:31:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:02 INFO - Installing pip.................done. 08:31:02 INFO - Return code: 0 08:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:31:02 INFO - Reading from file tmpfile_stdout 08:31:02 INFO - Output received: 08:31:02 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) 08:31:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:31:02 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')]} 08:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:02 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')]} 08:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:02 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:02 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 08:31:02 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 08:31:02 INFO - Using env: {'DISPLAY': ':0', 08:31:02 INFO - 'HOME': '/home/cltbld', 08:31:02 INFO - 'LANG': 'en_US.UTF-8', 08:31:02 INFO - 'LANGUAGE': 'en_US:en', 08:31:02 INFO - 'LOGNAME': 'cltbld', 08:31:02 INFO - 'MAIL': '/var/mail/cltbld', 08:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:02 INFO - 'MOZ_NO_REMOTE': '1', 08:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:02 INFO - 'NO_EM_RESTART': '1', 08:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:02 INFO - 'PWD': '/builds/slave/test', 08:31:02 INFO - 'SHELL': '/bin/bash', 08:31:02 INFO - 'SHLVL': '1', 08:31:02 INFO - 'TERM': 'linux', 08:31:02 INFO - 'TMOUT': '86400', 08:31:02 INFO - 'USER': 'cltbld', 08:31:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:02 INFO - '_': '/tools/buildbot/bin/python'} 08:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:02 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 08:31:02 INFO - Cleaning up... 08:31:02 INFO - Return code: 0 08:31:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:31:02 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')]} 08:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:02 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')]} 08:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:02 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:02 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 08:31:02 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 08:31:02 INFO - Using env: {'DISPLAY': ':0', 08:31:02 INFO - 'HOME': '/home/cltbld', 08:31:02 INFO - 'LANG': 'en_US.UTF-8', 08:31:02 INFO - 'LANGUAGE': 'en_US:en', 08:31:02 INFO - 'LOGNAME': 'cltbld', 08:31:02 INFO - 'MAIL': '/var/mail/cltbld', 08:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:02 INFO - 'MOZ_NO_REMOTE': '1', 08:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:02 INFO - 'NO_EM_RESTART': '1', 08:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:02 INFO - 'PWD': '/builds/slave/test', 08:31:02 INFO - 'SHELL': '/bin/bash', 08:31:02 INFO - 'SHLVL': '1', 08:31:02 INFO - 'TERM': 'linux', 08:31:02 INFO - 'TMOUT': '86400', 08:31:02 INFO - 'USER': 'cltbld', 08:31:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:02 INFO - '_': '/tools/buildbot/bin/python'} 08:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:02 INFO - Downloading/unpacking psutil>=3.1.1 08:31:02 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 08:31:02 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 08:31:02 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 08:31:02 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 08:31:02 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 08:31:02 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 08:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:04 INFO - Installing collected packages: psutil 08:31:04 INFO - Running setup.py install for psutil 08:31:04 INFO - building 'psutil._psutil_linux' extension 08:31:04 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 08:31:05 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 08:31:05 INFO - building 'psutil._psutil_posix' extension 08:31:05 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 08:31:05 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 08:31:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:05 INFO - Successfully installed psutil 08:31:05 INFO - Cleaning up... 08:31:05 INFO - Return code: 0 08:31:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:31:05 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')]} 08:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:05 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')]} 08:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:05 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:05 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 08:31:05 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 08:31:05 INFO - Using env: {'DISPLAY': ':0', 08:31:05 INFO - 'HOME': '/home/cltbld', 08:31:05 INFO - 'LANG': 'en_US.UTF-8', 08:31:05 INFO - 'LANGUAGE': 'en_US:en', 08:31:05 INFO - 'LOGNAME': 'cltbld', 08:31:05 INFO - 'MAIL': '/var/mail/cltbld', 08:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:05 INFO - 'MOZ_NO_REMOTE': '1', 08:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:05 INFO - 'NO_EM_RESTART': '1', 08:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:05 INFO - 'PWD': '/builds/slave/test', 08:31:05 INFO - 'SHELL': '/bin/bash', 08:31:05 INFO - 'SHLVL': '1', 08:31:05 INFO - 'TERM': 'linux', 08:31:05 INFO - 'TMOUT': '86400', 08:31:05 INFO - 'USER': 'cltbld', 08:31:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:05 INFO - '_': '/tools/buildbot/bin/python'} 08:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:31:07 INFO - Installing collected packages: mozsystemmonitor 08:31:07 INFO - Running setup.py install for mozsystemmonitor 08:31:07 INFO - Successfully installed mozsystemmonitor 08:31:07 INFO - Cleaning up... 08:31:07 INFO - Return code: 0 08:31:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:07 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 08:31:07 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 08:31:07 INFO - Using env: {'DISPLAY': ':0', 08:31:07 INFO - 'HOME': '/home/cltbld', 08:31:07 INFO - 'LANG': 'en_US.UTF-8', 08:31:07 INFO - 'LANGUAGE': 'en_US:en', 08:31:07 INFO - 'LOGNAME': 'cltbld', 08:31:07 INFO - 'MAIL': '/var/mail/cltbld', 08:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:07 INFO - 'MOZ_NO_REMOTE': '1', 08:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:07 INFO - 'NO_EM_RESTART': '1', 08:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:07 INFO - 'PWD': '/builds/slave/test', 08:31:07 INFO - 'SHELL': '/bin/bash', 08:31:07 INFO - 'SHLVL': '1', 08:31:07 INFO - 'TERM': 'linux', 08:31:07 INFO - 'TMOUT': '86400', 08:31:07 INFO - 'USER': 'cltbld', 08:31:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:07 INFO - '_': '/tools/buildbot/bin/python'} 08:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:31:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:31:10 INFO - warning: no files found matching '*.txt' 08:31:10 INFO - no previously-included directories found matching 'build' 08:31:10 INFO - no previously-included directories found matching 'dist' 08:31:10 INFO - no previously-included directories found matching '.git*' 08:31:10 INFO - Installing collected packages: jsonschema, functools32 08:31:10 INFO - Running setup.py install for functools32 08:31:10 INFO - warning: no files found matching '*.txt' 08:31:10 INFO - no previously-included directories found matching 'build' 08:31:10 INFO - no previously-included directories found matching 'dist' 08:31:10 INFO - no previously-included directories found matching '.git*' 08:31:10 INFO - Successfully installed jsonschema functools32 08:31:10 INFO - Cleaning up... 08:31:10 INFO - Return code: 0 08:31:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:10 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:10 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 08:31:10 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 08:31:10 INFO - Using env: {'DISPLAY': ':0', 08:31:10 INFO - 'HOME': '/home/cltbld', 08:31:10 INFO - 'LANG': 'en_US.UTF-8', 08:31:10 INFO - 'LANGUAGE': 'en_US:en', 08:31:10 INFO - 'LOGNAME': 'cltbld', 08:31:10 INFO - 'MAIL': '/var/mail/cltbld', 08:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:10 INFO - 'MOZ_NO_REMOTE': '1', 08:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:10 INFO - 'NO_EM_RESTART': '1', 08:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:10 INFO - 'PWD': '/builds/slave/test', 08:31:10 INFO - 'SHELL': '/bin/bash', 08:31:10 INFO - 'SHLVL': '1', 08:31:10 INFO - 'TERM': 'linux', 08:31:10 INFO - 'TMOUT': '86400', 08:31:10 INFO - 'USER': 'cltbld', 08:31:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:10 INFO - '_': '/tools/buildbot/bin/python'} 08:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:31:10 INFO - Cleaning up... 08:31:10 INFO - Return code: 0 08:31:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:10 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:10 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 08:31:10 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 08:31:10 INFO - Using env: {'DISPLAY': ':0', 08:31:10 INFO - 'HOME': '/home/cltbld', 08:31:10 INFO - 'LANG': 'en_US.UTF-8', 08:31:10 INFO - 'LANGUAGE': 'en_US:en', 08:31:10 INFO - 'LOGNAME': 'cltbld', 08:31:10 INFO - 'MAIL': '/var/mail/cltbld', 08:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:10 INFO - 'MOZ_NO_REMOTE': '1', 08:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:10 INFO - 'NO_EM_RESTART': '1', 08:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:10 INFO - 'PWD': '/builds/slave/test', 08:31:10 INFO - 'SHELL': '/bin/bash', 08:31:10 INFO - 'SHLVL': '1', 08:31:10 INFO - 'TERM': 'linux', 08:31:10 INFO - 'TMOUT': '86400', 08:31:10 INFO - 'USER': 'cltbld', 08:31:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:10 INFO - '_': '/tools/buildbot/bin/python'} 08:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 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 08:31:10 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 08:31:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:31:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 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 08:31:13 INFO - Downloading docopt-0.6.1.tar.gz 08:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:13 INFO - Running setup.py install for blobuploader 08:31:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:31:13 INFO - Running setup.py install for requests 08:31:14 INFO - Running setup.py install for docopt 08:31:14 INFO - Successfully installed blobuploader requests docopt 08:31:14 INFO - Cleaning up... 08:31:14 INFO - Return code: 0 08:31:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:14 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:14 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 08:31:14 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 08:31:14 INFO - Using env: {'DISPLAY': ':0', 08:31:14 INFO - 'HOME': '/home/cltbld', 08:31:14 INFO - 'LANG': 'en_US.UTF-8', 08:31:14 INFO - 'LANGUAGE': 'en_US:en', 08:31:14 INFO - 'LOGNAME': 'cltbld', 08:31:14 INFO - 'MAIL': '/var/mail/cltbld', 08:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:14 INFO - 'MOZ_NO_REMOTE': '1', 08:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:14 INFO - 'NO_EM_RESTART': '1', 08:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:14 INFO - 'PWD': '/builds/slave/test', 08:31:14 INFO - 'SHELL': '/bin/bash', 08:31:14 INFO - 'SHLVL': '1', 08:31:14 INFO - 'TERM': 'linux', 08:31:14 INFO - 'TMOUT': '86400', 08:31:14 INFO - 'USER': 'cltbld', 08:31:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:14 INFO - '_': '/tools/buildbot/bin/python'} 08:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:14 INFO - Running setup.py (path:/tmp/pip-Crs84t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:14 INFO - Running setup.py (path:/tmp/pip-oskyvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:14 INFO - Running setup.py (path:/tmp/pip-3b6iZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:14 INFO - Running setup.py (path:/tmp/pip-KDkIwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:14 INFO - Running setup.py (path:/tmp/pip-UExddg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:15 INFO - Running setup.py (path:/tmp/pip-ZyhAqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:15 INFO - Running setup.py (path:/tmp/pip-irLwWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:15 INFO - Running setup.py (path:/tmp/pip-mvoSzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:15 INFO - Running setup.py (path:/tmp/pip-mdOIsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:15 INFO - Running setup.py (path:/tmp/pip-5aaDqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:15 INFO - Running setup.py (path:/tmp/pip-0OWXQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:15 INFO - Running setup.py (path:/tmp/pip-SLwLew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:15 INFO - Running setup.py (path:/tmp/pip-iQST8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:15 INFO - Running setup.py (path:/tmp/pip-KaDiYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:15 INFO - Running setup.py (path:/tmp/pip-yWgDG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:15 INFO - Running setup.py (path:/tmp/pip-Xs4WaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:15 INFO - Running setup.py (path:/tmp/pip-blDU3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:15 INFO - Running setup.py install for manifestparser 08:31:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Running setup.py install for mozcrash 08:31:16 INFO - Running setup.py install for mozdebug 08:31:16 INFO - Running setup.py install for mozdevice 08:31:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for mozfile 08:31:16 INFO - Running setup.py install for mozhttpd 08:31:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for mozinfo 08:31:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for mozInstall 08:31:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for mozleak 08:31:16 INFO - Running setup.py install for mozlog 08:31:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for moznetwork 08:31:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:31:17 INFO - Running setup.py install for mozprocess 08:31:17 INFO - Running setup.py install for mozprofile 08:31:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:31:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:31:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:31:17 INFO - Running setup.py install for mozrunner 08:31:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:31:17 INFO - Running setup.py install for mozscreenshot 08:31:17 INFO - Running setup.py install for moztest 08:31:17 INFO - Running setup.py install for mozversion 08:31:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:31:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:17 INFO - Cleaning up... 08:31:17 INFO - Return code: 0 08:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:17 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:17 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 08:31:17 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 08:31:17 INFO - Using env: {'DISPLAY': ':0', 08:31:17 INFO - 'HOME': '/home/cltbld', 08:31:17 INFO - 'LANG': 'en_US.UTF-8', 08:31:17 INFO - 'LANGUAGE': 'en_US:en', 08:31:17 INFO - 'LOGNAME': 'cltbld', 08:31:17 INFO - 'MAIL': '/var/mail/cltbld', 08:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:17 INFO - 'MOZ_NO_REMOTE': '1', 08:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:17 INFO - 'NO_EM_RESTART': '1', 08:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:17 INFO - 'PWD': '/builds/slave/test', 08:31:17 INFO - 'SHELL': '/bin/bash', 08:31:17 INFO - 'SHLVL': '1', 08:31:17 INFO - 'TERM': 'linux', 08:31:17 INFO - 'TMOUT': '86400', 08:31:17 INFO - 'USER': 'cltbld', 08:31:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:17 INFO - '_': '/tools/buildbot/bin/python'} 08:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:17 INFO - Running setup.py (path:/tmp/pip-9WH81k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:17 INFO - Running setup.py (path:/tmp/pip-UwKKNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:18 INFO - Running setup.py (path:/tmp/pip-qbhjdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:18 INFO - Running setup.py (path:/tmp/pip-NR_njw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:18 INFO - Running setup.py (path:/tmp/pip-4zHkcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:18 INFO - Running setup.py (path:/tmp/pip-8LjV91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:18 INFO - Running setup.py (path:/tmp/pip-nf20mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:18 INFO - Running setup.py (path:/tmp/pip-UygCKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:18 INFO - Running setup.py (path:/tmp/pip-9dLIS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:18 INFO - Running setup.py (path:/tmp/pip-SYry6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:18 INFO - Running setup.py (path:/tmp/pip-CySdYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:18 INFO - Running setup.py (path:/tmp/pip-ZZvN_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:18 INFO - Running setup.py (path:/tmp/pip-X0vj_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:18 INFO - Running setup.py (path:/tmp/pip-Z2jb9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:18 INFO - Running setup.py (path:/tmp/pip-tmbJGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:19 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)) 08:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:19 INFO - Running setup.py (path:/tmp/pip-ZQgnDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:19 INFO - Running setup.py (path:/tmp/pip-6v9tdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:19 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)) 08:31:19 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)) 08:31:19 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)) 08:31:19 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)) 08:31:19 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)) 08:31:19 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)) 08:31:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:21 INFO - Downloading blessings-1.6.tar.gz 08:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:21 INFO - Installing collected packages: blessings 08:31:21 INFO - Running setup.py install for blessings 08:31:21 INFO - Successfully installed blessings 08:31:21 INFO - Cleaning up... 08:31:21 INFO - Return code: 0 08:31:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:21 INFO - Reading from file tmpfile_stdout 08:31:21 INFO - Current package versions: 08:31:21 INFO - argparse == 1.2.1 08:31:21 INFO - blessings == 1.6 08:31:21 INFO - blobuploader == 1.2.4 08:31:21 INFO - docopt == 0.6.1 08:31:21 INFO - functools32 == 3.2.3-2 08:31:21 INFO - jsonschema == 2.5.1 08:31:21 INFO - manifestparser == 1.1 08:31:21 INFO - mozInstall == 1.12 08:31:21 INFO - mozcrash == 1.0 08:31:21 INFO - mozdebug == 0.1 08:31:21 INFO - mozdevice == 0.48 08:31:21 INFO - mozfile == 1.2 08:31:21 INFO - mozhttpd == 0.7 08:31:21 INFO - mozinfo == 0.9 08:31:21 INFO - mozleak == 0.1 08:31:21 INFO - mozlog == 3.4 08:31:21 INFO - moznetwork == 0.27 08:31:21 INFO - mozprocess == 0.23 08:31:21 INFO - mozprofile == 0.28 08:31:21 INFO - mozrunner == 6.13 08:31:21 INFO - mozscreenshot == 0.1 08:31:21 INFO - mozsystemmonitor == 0.3 08:31:21 INFO - moztest == 0.8 08:31:21 INFO - mozversion == 1.4 08:31:21 INFO - psutil == 3.1.1 08:31:21 INFO - requests == 1.2.3 08:31:21 INFO - wsgiref == 0.1.2 08:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:21 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')]} 08:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:21 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')]} 08:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:21 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:21 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 08:31:21 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 08:31:21 INFO - Using env: {'DISPLAY': ':0', 08:31:21 INFO - 'HOME': '/home/cltbld', 08:31:21 INFO - 'LANG': 'en_US.UTF-8', 08:31:21 INFO - 'LANGUAGE': 'en_US:en', 08:31:21 INFO - 'LOGNAME': 'cltbld', 08:31:21 INFO - 'MAIL': '/var/mail/cltbld', 08:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:21 INFO - 'MOZ_NO_REMOTE': '1', 08:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:21 INFO - 'NO_EM_RESTART': '1', 08:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:21 INFO - 'PWD': '/builds/slave/test', 08:31:21 INFO - 'SHELL': '/bin/bash', 08:31:21 INFO - 'SHLVL': '1', 08:31:21 INFO - 'TERM': 'linux', 08:31:21 INFO - 'TMOUT': '86400', 08:31:21 INFO - 'USER': 'cltbld', 08:31:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:21 INFO - '_': '/tools/buildbot/bin/python'} 08:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 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)) 08:31:21 INFO - Cleaning up... 08:31:21 INFO - Return code: 0 08:31:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:31:21 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')]} 08:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:21 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')]} 08:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:21 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 0x7fb191305f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2374ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', '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 08:31:21 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 08:31:21 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 08:31:21 INFO - Using env: {'DISPLAY': ':0', 08:31:21 INFO - 'HOME': '/home/cltbld', 08:31:21 INFO - 'LANG': 'en_US.UTF-8', 08:31:21 INFO - 'LANGUAGE': 'en_US:en', 08:31:21 INFO - 'LOGNAME': 'cltbld', 08:31:21 INFO - 'MAIL': '/var/mail/cltbld', 08:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:21 INFO - 'MOZ_NO_REMOTE': '1', 08:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:21 INFO - 'NO_EM_RESTART': '1', 08:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:21 INFO - 'PWD': '/builds/slave/test', 08:31:21 INFO - 'SHELL': '/bin/bash', 08:31:21 INFO - 'SHLVL': '1', 08:31:21 INFO - 'TERM': 'linux', 08:31:21 INFO - 'TMOUT': '86400', 08:31:21 INFO - 'USER': 'cltbld', 08:31:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:21 INFO - '_': '/tools/buildbot/bin/python'} 08:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:31:22 INFO - Cleaning up... 08:31:22 INFO - Return code: 0 08:31:22 INFO - Running post-action listener: _resource_record_post_action 08:31:22 INFO - Running post-action listener: _start_resource_monitoring 08:31:22 INFO - Starting resource monitoring. 08:31:22 INFO - [mozharness: 2017-01-16 16:31:22.157718Z] Finished create-virtualenv step (success) 08:31:22 INFO - [mozharness: 2017-01-16 16:31:22.158172Z] Running install step. 08:31:22 INFO - Running pre-action listener: _resource_record_pre_action 08:31:22 INFO - Running main action method: install 08:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:22 INFO - Reading from file tmpfile_stdout 08:31:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:31:22 INFO - Reading from file tmpfile_stdout 08:31:22 INFO - Output received: 08:31:22 INFO - Usage: mozinstall [options] installer 08:31:22 INFO - Options: 08:31:22 INFO - -h, --help show this help message and exit 08:31:22 INFO - -d DEST, --destination=DEST 08:31:22 INFO - Directory to install application into. [default: 08:31:22 INFO - "/builds/slave/test"] 08:31:22 INFO - --app=APP Application being installed. [default: firefox] 08:31:22 INFO - mkdir: /builds/slave/test/build/application 08:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:31:39 INFO - Reading from file tmpfile_stdout 08:31:39 INFO - Output received: 08:31:39 INFO - /builds/slave/test/build/application/firefox/firefox 08:31:39 INFO - Running post-action listener: _resource_record_post_action 08:31:39 INFO - [mozharness: 2017-01-16 16:31:39.167046Z] Finished install step (success) 08:31:39 INFO - [mozharness: 2017-01-16 16:31:39.167288Z] Running run-tests step. 08:31:39 INFO - Running pre-action listener: _resource_record_pre_action 08:31:39 INFO - Running main action method: run_tests 08:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:31:39 INFO - Python 2.7.3 08:31:39 INFO - Return code: 0 08:31:39 INFO - grabbing minidump binary from tooltool 08:31:39 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')]} 08:31:39 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 0x2371f60>, '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 0x2372d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23731d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:31:39 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 08:31:39 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 08:31:39 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 08:31:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:31:39 INFO - Return code: 0 08:31:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:31:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:31:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:31:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:31:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 08:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 08:31:39 INFO - Using env: {'DISPLAY': ':0', 08:31:39 INFO - 'HOME': '/home/cltbld', 08:31:39 INFO - 'LANG': 'en_US.UTF-8', 08:31:39 INFO - 'LANGUAGE': 'en_US:en', 08:31:39 INFO - 'LOGNAME': 'cltbld', 08:31:39 INFO - 'MAIL': '/var/mail/cltbld', 08:31:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:31:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:39 INFO - 'MOZ_NO_REMOTE': '1', 08:31:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:39 INFO - 'NO_EM_RESTART': '1', 08:31:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:39 INFO - 'PWD': '/builds/slave/test', 08:31:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:31:39 INFO - 'SHELL': '/bin/bash', 08:31:39 INFO - 'SHLVL': '1', 08:31:39 INFO - 'TERM': 'linux', 08:31:39 INFO - 'TMOUT': '86400', 08:31:39 INFO - 'USER': 'cltbld', 08:31:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032', 08:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:39 INFO - '_': '/tools/buildbot/bin/python'} 08:31:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 08:31:39 INFO - mozversion application_buildid: 20170116065021 08:31:39 INFO - mozversion application_changeset: 325b6cc5bca7a794aad8b77d9ba12303866f5b91 08:31:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:31:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:31:39 INFO - mozversion application_name: Firefox 08:31:39 INFO - mozversion application_remotingname: firefox-dev 08:31:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:31:39 INFO - mozversion application_vendor: Mozilla 08:31:39 INFO - mozversion application_version: 52.0a2 08:31:39 INFO - mozversion platform_buildid: 20170116065021 08:31:39 INFO - mozversion platform_changeset: 325b6cc5bca7a794aad8b77d9ba12303866f5b91 08:31:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:31:39 INFO - mozversion platform_version: 52.0a2 08:31:39 INFO - using testdate: 1484584299 08:31:39 INFO - actual date: 1484584299 08:31:39 INFO - starting webserver on 'localhost:45176' 08:31:39 INFO - SUITE-START | Running 2 tests 08:31:39 INFO - TEST-START | dromaeo_css 08:31:39 INFO - operating with platform_type : linux_ 08:31:39 INFO - Initialising browser for dromaeo_css test... 08:31:39 INFO - TEST-INFO | started process 9757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpImffzo/profile http://localhost:45176/getInfo.html) 08:31:43 INFO - PROCESS | 9757 | __metrics Screen width/height:1600/1200 08:31:43 INFO - PROCESS | 9757 | colorDepth:24 08:31:43 INFO - PROCESS | 9757 | Browser inner width/height: 1024/697 08:31:43 INFO - PROCESS | 9757 | __metrics 08:31:43 INFO - PROCESS | 9757 | 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:31:43 INFO - PROCESS | 9757 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:44 INFO - PROCESS | 9757 | console.error: PushService: 08:31:44 INFO - PROCESS | 9757 | stateChangeProcessEnqueue: Error transitioning state 08:31:44 INFO - PROCESS | 9757 | UnknownError 08:31:45 INFO - TEST-INFO | 9757: exit 0 08:31:45 INFO - Browser initialized. 08:31:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:31:45 INFO - TEST-INFO | started process 9847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpImffzo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:56 INFO - PROCESS | 9847 | RSS: Main: 144076800 08:31:56 INFO - PROCESS | 9847 | 08:34:58 INFO - PROCESS | 9847 | Cycle 1(1): loaded http://localhost:45176/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45176/tests/dromaeo/cssquery-ext.html) 08:34:59 INFO - PROCESS | 9847 | RSS: Main: 251756544 08:34:59 INFO - PROCESS | 9847 | 08:38:01 INFO - PROCESS | 9847 | Cycle 1(1): loaded http://localhost:45176/tests/dromaeo/cssquery-ext.html (next: http://localhost:45176/tests/dromaeo/cssquery-jquery.html) 08:38:02 INFO - PROCESS | 9847 | RSS: Main: 230739968 08:38:02 INFO - PROCESS | 9847 | 08:41:04 INFO - PROCESS | 9847 | Cycle 1(1): loaded http://localhost:45176/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45176/tests/dromaeo/cssquery-mootools.html) 08:41:05 INFO - PROCESS | 9847 | RSS: Main: 175460352 08:41:05 INFO - PROCESS | 9847 | 08:44:07 INFO - PROCESS | 9847 | Cycle 1(1): loaded http://localhost:45176/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45176/tests/dromaeo/cssquery-prototype.html) 08:44:07 INFO - PROCESS | 9847 | RSS: Main: 175759360 08:44:07 INFO - PROCESS | 9847 | 08:47:10 INFO - PROCESS | 9847 | Cycle 1(1): loaded http://localhost:45176/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45176/tests/dromaeo/cssquery-yui.html) 08:47:10 INFO - PROCESS | 9847 | RSS: Main: 177025024 08:47:10 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | Cycle 1(1): loaded http://localhost:45176/tests/dromaeo/cssquery-yui.html (next: http://localhost:45176/tests/dromaeo/cssquery-dojo.html) 08:50:13 INFO - PROCESS | 9847 | RSS: Main: 270118912 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | __start_tp_report 08:50:13 INFO - PROCESS | 9847 | _x_x_mozilla_page_load 08:50:13 INFO - PROCESS | 9847 | _x_x_mozilla_page_load_details 08:50:13 INFO - PROCESS | 9847 | |i|pagename|runs| 08:50:13 INFO - PROCESS | 9847 | |0;dojo.html;3180.7137357637816;3222.3716375306794;3223.629282632498;3224.85488153033;3251.7561182911286;5381.677099374036;5480.7533660985255;5500.642458240217;5502.284702988606;5508.55931525478;5554.666719996803;5566.387697353288;5567.916481252784;5572.136318870572;5602.467765562275;5014.2979982802435;5044.016416798726;5060.6963582185;5073.452596957926;5121.129408000649;4862.246351815475;5065.214891691794;5117.1556693145585;5118.488151184889;5146.0222557714105;4841.903161936777;4928.088303663816;4977.900441991158;5020.246962955549;5026.899462010758;5043.722595257278;5061.54446099851;5126.179811230185;5129.6922184668665;5153.974230128825;4785.641076919245;5015.899682006339;5038.773255203488;5069.822556210552;5099.413567439755;5346.759395827197;5364.1149210380245;5414.756335964891;5427.43011983744;5446.428125046853;5832.475077243026;5851.034579294412;5952.523798096186;5959.880802383971;5972;5647.576431767634;5692.77228910843;5993.640381577119;5998.28020637522;6010.218671572711;5469.72651367434;5536.446355364431;5541.639793413416;5564.19319198722;5598.1322894951345;6101.328853826076;6104.38956104386;6108.175396321529;6111.297200821873;6120.78577249803;5542.196381524737;5584.91622625661;5852.326982396994;5856.531477481792;5860.443257890493;5729.942700573024;5800.01399762033;5817.127430885401;5854.619449735754;5885.882282354329;5810.854728631818;5813.04084825999;5815.767369305265;5816.709164541756;5852.239208902815;5669.546436285087;5752.223449834219;5794.188813566104;5816.447437493432;5817.680027598438;4435.756033418128;4514.977425112854;4546.818127274938;4562.475315338778;4627.3521706961055;4086.2849001424634;4093.324601440729;4099.815508302134;4106.384042393605;4108.383742438598;5369.704666243316;5640.182173584807;5646.520045796071;5655.971720141373;5677.659340439587;5705;5729.054705973551;5734.455226753452;5747.540196784247;5873.442023007808;5514.979728750194;5521.309836270466;5524.889502209933;5525.088360420566;5525.475079867406;5056.544910957958;5069.518395752398;5070.645054846199;5070.873228169252;5102.2346648003095;5867.530597552186;5923.881522369528;6045.697715114315;6130.795626845359;6139.171211886338;5945.821625351074;5970.850728731816;5970.910436343545;5974.910376344272;5984.16221728967;6125.356837531995;6195.411435913581;6195.977663685441;6199;6201.503879689704;5500.119980803052;5586.441355864381;5617.859553511195;5662.462066103713;5822.2140011099655;5733.197352370755;5757.424257574209;5759.568032397503;5766.106253530709;5771.307443106686;5626.606137570331;5627.43725627434;5630.099184130683;5635.464630860061;5639.859003524781;5553.555715542666;5556.027695153412;5589;5601.691906945157;5603.411641777555;5672.262605861211;5729;5745.885082298414;5777.422257774189;5784.2769653793275;5800.9419905800405;5842.328132264844;5851.239338885917;5857.47282744555;5863.530917526502;5368.2752828367675;5368.436314186954;5554.361248456317;5628.605997580294;5699.629524080921 08:50:13 INFO - PROCESS | 9847 | |1;ext.html;578.7424596054755;629.9653519056451;646.8673921846022;655.3839390972486;660.4485254812231;34422.48366274508;37577.06057348568;37839.81080094599;45876;47421;47613;48038.279425808556;48046.27930581044;48067;48128.759356203256;8839.823203535942;8989.640414383417;8991.055939126396;8993.865092023625;9006;8479.194476524752;8660.653573857038;8669.739907802776;8945.95527022364;10610.416427096507;10673.78652426951;11000.834987475195;11001.1749118816;11016.11871050314;11020.559177632886;10825.188110891715;10831.970962758525;10878.782424351548;10894.237403381767;10898.291611045297;10747.570097196181;10784.892151078546;10808.621698240602;10814.51334689933;10822.729431764268;44865.77567112144;45187.096258074984;45210.09579808386;45217;45260.77369613164;3528.7177025837873;3738.756980796267;3759.0602349412648;3960.485136932209;4112.424260603518;34231;34434.139146521535;34815;36500.269994600225;36605;4511.323301504768;4537.636989040869;4578.198815207359;4620.145273124483;4757.643176761757;333252;336787;338620;339172;339610;64051;64280.67859660765;64334;64354.678226608565;64377.03434448487;39423.802880985415;40940.1811963759;40949.79525102415;43692.563074369486;43728.56271437309;17012.319507219574;17229;17237.224324905408;17247.56881077983;17248.741268880978;12483.750324993449;12568.30874301922;12620.17968832023;12635.115541911979;12696.17474864131;18910.338138165374;19537.80462195388;20287.79712202859;21144;21147.471313216985;7076.292370762985;7201.675924583406;7218.530795498275;7340.522866013692;7408.740694075682;1007.7279134633608;1043.403592503471;1083.983740243897;1114.8773634900153;1153.5789436855487;35082.64917350845;35528.61430043153;35584;35618.286285286034;35627.4655880162;1127.8984891359817;1153.0717772193298;1166.3002198680724;1174.7826652069396;1220.682622518134;18341.54146146357;18490;18607.16267767954;18751.90624046871;18761.90619046896;539110;547732;548800;550250;550270;54878.17682734762;56138.7193064032;59573.702131489066;61854.69072654698;61983.690081549306;1374.7387996280675;1392.303848075962;1416.5608661315025;1416.7379034878581;1416.9929150354183;33139.50290745689;35165.47251791276;35314.646853531136;35879.282414351044;36034;56416.15375769449;56752.71623641856;56901;56910.71544642416;56934;493971;506643;511828;724328;726851;47150.29274560816;47345;47530.76234618805;47633;47780.04439911252;51828.48171518387;51844.222336665734;52153.30857174346;53032;53114;43943.56056439522;44975.550244498445;45048.324275136554;45395;46860.29709554427;44040.55959440365;44690.106197876514;45460;45886.31170532378;46293.53706462892;44019.11961760811;44265.33601996037;44543;44992;45158.32262515999;36242.81878590696;39240.215195696495;39419.2116157681;39546.38438164015;39999.400008999306;30013.849930750206;30205.69794302029;30383.24041898882;30463.543046854757;30571.2357191072 08:50:13 INFO - PROCESS | 9847 | |2;jquery.html;389.17494910789134;414.1695899721057;423.7859880760217;423.99364009539863;428.16935145817115;16707.916460417695;19110.331138410158;19589.51026224345;19692.507687307807;20182.293619723314;19722.506937326572;19842.801571984277;19865.106070226837;19909.800901990977;20032;5236.581073514109;5523.889522209553;5760.913586296209;6402.839929001789;6451.967740161316;6480.4815614750705;6482.092507049017;6532.902006469907;6557.409833115019;6559.3112723164095;6183.134361189437;6295.811125666238;6299.0551417287315;6301.306856245809;6416.3262857400005;5681.687507187103;5866.501347385477;6380.393862583047;6398.29618741938;6407.839804004914;5860.677662728548;5868.149118377854;5871.735771890275;5874.060150375919;5878.676672782995;13610.183388996691;22559.323220303417;23302.300930971927;23450.530989380117;24439.26682199537;2253.5830871288863;2445.7431969643285;2479.566075936704;2797.818141820775;2932.8838034997825;11302.660920172408;11398.202125851194;11475.426228688615;14542.054766440147;14931.776023359658;1865.6362009408172;1921.3947606503907;1945.7373254610588;1961.4311849563753;2031.5022819409191;58738;74949.62525187393;75468;82026;83203.58398208031;11820;11899.88100119005;11932.28406295625;11984.820227696591;12006.699832504082;16658.833411665728;16714.498565043068;16718;16753.748693769605;16777.832221677872;8327.625941719549;8354.791130221793;8391.412601117863;8533.701320453754;8597.484150950962;7856.84286314282;7860.410469214832;7894.526328420313;8114.837703245902;8115.431919765678;4974.801007959641;5110.821121260738;5125.589952803767;5136.306598609214;5276.841694749163;1851.231738828398;2009.437357539862;2045.9106748809108;2090.989545052265;2146.098638571804;1026.8140050697102;1036.5439206749006;1051.64244156987;1070.1545778834634;1109.9223054386277;20230.291939782037;20311.898440507703;20369.89815050945;20448.36413086979;20792.1683132673;986.5954958466995;1020.9948950255201;1022.3508072374096;1097.846301517788;1109.8945600167972;10640.361578305326;11517.942410288062;11543.134264930164;11701.414929253504;11705.941470292593;494192;511099;513287;514499;522489;95813;105252.47373763235;105278;106074;107243;1006.6728313298061;1014.91373233276;1043.7599352148895;1054.99472502637;1056.963006294776;17807;18200.72698909491;18536.25854965786;18683.800311762887;18991.525211869262;31752.206194844388;43018.35472467853;43999.70121753802;44240.11519769651;44696.32955505605;56518.15222771579;60366;60783.69608151931;61931;62963.37036629575;8675.91324086751;9210.907890921006;9244.168024877794;9346.485943273185;9528.809423811623;10970.506327215135;13709.423416306854;13766.31168441594;13989.510367137102;13998.580042598738;11615.5934542294;12074.637760867188;12091.15361924692;12376.938115309726;12432.12975091735;11891.702707432383;12083.093767967262;12374.81437778416;12470.688232794253;12514.249145051326;11639.6508104757;12366.876331236572;12374.195677280948;12621.368931553568;12715.237085774883;8778.736637900873;8994.370394072614;9048.366614336934;9164.587593558172;9355.625774968925;11166.720831979266;12240.87759122433;12253.632391027926;12284.631461056182;12304.200226985216 08:50:13 INFO - PROCESS | 9847 | |3;mootools.html;1449.8912581556385;1488.6576087499875;1628.9429869954554;1735.2191513818784;1783.4382169616579;7878.409119316053;8384.790380240482;8401.83196336073;8402.49585024899;8407.747767566967;7296.817579560514;7477.850442991151;8127.634256458458;8312.8753068704;8320.583970801466;2416.03358656537;2433.634954756783;2442.8778561071877;2444.608862581987;2444.9388765280833;2426.611742121261;2434.184548176363;2452.5462789383932;2456.8648724320155;2457.8033757299463;2387.7970372518357;2390.4262976885598;2416.9516609667794;2420.636904464327;2422.769836865495;2342.543204075206;2344.2146880794953;2368.4789346343864;2369.111583156325;2370.656254843038;2336.5326934613145;2366.479374537599;2394.31761947844;2400.447896983686;2403.267003563912;8447.662093516252;8493.915060849436;8499.192576705203;8503.319734421293;8508.276796472308;5217.791288348461;5347.812826551052;5352;5356.035913535601;5358.4373640767935;3322.0864262328055;3332.067021234034;3364.0748794081824;3367.1245476176127;3429.3141371725505;1158.154547180563;1168.5968340922368;1172.5016867831137;1181.5628217559558;1201.585453018707;11158.776824463546;11186.496607652674;11237.494312755945;11240.775184496264;11257.493412796444;4303.913921721548;4473.351364052194;4528.230200865861;4567.018091110427;4571.085782843445;9306.72079837606;9317.72046838596;9320.254379649612;9337.486438245962;9351.345405821527;5243.528082472596;5246.868828279247;5251.212318152231;5252.05463016653;5261.657992230493;4280.571942805695;4353.36876152956;4509.594136527729;4890.657653964259;4929.852104436801;3838.616138386195;3864.2271545690974;3908.6482216600643;3952.505936757905;3959.208158368338;1195.0678470792795;1199.6221190325193;1204.644629834201;1205.6202296276645;1214.8967337776212;888.5868071346855;1015.827309357411;1018.4144117132678;1023.8413045977885;1031.4275577054657;5749.798757043483;5842.065269556935;5863.149843272701;5968.134620480006;6017.789377371859;492.396813902966;493.0262731106109;493.74588545095054;1020.357174979758;1042.635077722791;3867.806609669505;4104.979475102606;4175.519815221228;4197.685173611992;4277.957220427818;10089.949550252202;10570.577176912991;10573.154147668169;10576.947115264375;10590.523426445829;10452.477376131163;10452.581896724198;10463;10464.738381540523;10525.157987360994;8035.839283214303;8227.753167404988;8242.876356854653;8244.505329680238;8249.917500825035;5673.602847800615;5937.762489500372;6056.697165141637;6086.391360863879;6088.117223002551;9385.155336019518;9536.666216682383;9606.375585586915;9629.374090684083;9657.517124143624;9749.22006239485;9752.024797520191;9760.365576237522;9767.023297670175;9888.604455821687;6770.898436523555;6889;6922.10012698346;7535.849283014419;7685.346745526693;7815.53106813593;8062.717804876801;8125.512469251864;8130.796730081795;8143.552104634302;7110.680019399036;7208.855822883408;7220.927790722026;7245.891311630435;7306.159791624032;6904.344087311697;6959.826004349932;6978.581285122909;7026.402755765817;7095.148582169966;6526.477881769542;6656.600603963778;6658.3674550917585;6658.434033107046;6661.4337781287195;4968.205087186033;5029.4216165140015;5142.97428512855;5179.559737422362;5181;5275.762590683506;5297.364316282071;5403.604392106926;5413.621046526705;5427.755750991136 08:50:13 INFO - PROCESS | 9847 | |4;prototype.html;349.8425708431206;352.5293732866623;353.14186526740025;358.7524608020464;359.4285086712129;5440.455954404558;5442.156465747816;5472.616916815825;5484.28704268445;5495.587830912687;5372.355317361922;5379.408265090837;5390.7870729085935;5395.325584301962;5411.592985823685;3718.9814050929845;4011.5386730525925;4077.5106987161435;4115.629593336599;4199.4120823084795;4226.366045093245;4226.72526285792;4227.556106608808;4243.429930925547;4265.296226122686;4240.469941257343;4241.830326786925;4242.83028678854;4248.192843359767;4253.914921701564;4084.590816168432;4131.318332475138;4199.748015119103;4250.213710463574;4252.170826688797;3757.210985693008;3771.4531392948143;3775.565809931838;3777.5089238399105;3793.2413517296377;5252.159654455307;5281.603879708999;5283.154695248781;5287.603429742785;5290.724988255049;4751.31105989633;4807;4826.131296366688;4847.806087756486;4865.978144589641;5548.529639645457;5593.664380137164;5607.57943154261;5612.635178713412;5615.66306021636;4107.691923105779;4126.938095928564;4132.855350062763;4133;4138.317177665682;5595.104783234704;5739.426057394269;5750.827475175752;5810.24466819315;5811.593188476851;4223.4795473629465;4226.274053235646;4229.725067870579;4233.618974292329;4234.25900467417;4277.668670574544;4280.0369916769105;4281.981203251762;4282.807273672693;4285.185814695198;4643.95356046442;4749.525047495292;4750.667453278237;4755.809767609326;4832.661713680079;5575.470330318613;5591.860203494945;5610.971945140248;5617.831465055973;5663.150527420919;1412.2276542938546;1420.3821337718125;1420.6803469219342;1420.8152940117718;1433.426629348269;967.4098799732158;1020.1583693452783;1023.7133602591286;1035.6478797208986;1043.6588983156607;5149.716765577854;5236.895262094813;5244.895102098013;5264.4996176089635;5270.736463176902;5564.081926482166;5566.526845218121;5584.357798853102;5598.356189038313;5599.832005039855;5018.372703412074;5226.189940559219;5263.23683065961;5267.31524901768;5267.868303292448;2942.646882374129;2949;2955.2168675301064;2959.5412711029826;2966.718161774628;5770.480656740913;5788.668606220509;5791.160281759206;5793.797217097465;5794.884102318014;5621.065254321991;5704.543636509069;5933.525317974551;5936.1392598073035;5947.167396564398;5910.290765108214;5935.376785437467;6046.576739628272;6084.90872636902;6088.543359247986;5832.270966129234;5855.268091488564;5861.706914654335;5867.237259156283;5876.676782776988;5556.749946252347;5704.087346024616;5755.050416681201;5770.422957704196;5795.33353664334;5998.25021872266;6035.094735789667;6050.213472248755;6055.182550355822;6097.359777223328;4202.85290014848;4203.537610862863;4209.6000879916355;4211.599898009684;4218.55705150967;5605.075162598288;5848.912266316093;5857.853553661193;5894.882102358015;5906.169087582863;5701.629394089371;5703.800366987136;5706.372299047184;5723.914141287801;5737.713114344349;5531.649049154174;5668.5465162787705;5699.544036477155;5709.22925405065;5733.569982251432;5623.775048997994;5628.690422026828;5631.915521267102;5635.267415235993;5665.12190610456;5727.713614319351;5734.34055083654;5757.769689212385;5759.798407055733;5769.9711501442225;5443.8094666686475;5542.944570554243;5625.296837895263;5625.803096891589;5626.915596266142 08:50:13 INFO - PROCESS | 9847 | |5;yui.html;776.3788968824942;819.71719756684;822.8313195794861;846.4117438380324;890.799570096728;14484.203368814724;15762.92118539407;15947.043177409363;16099.517014489555;16228.675426491478;14561.563153105397;14751.704965900675;14785.482508112218;14904.180270085168;14930.328135233913;738.6528331684127;755.9924400756005;840.6427268410916;857.8756080368343;860.3289434241302;844.5734903873536;866.4324867211986;870.6691457246237;871.298604623278;871.376965469689;909.8908131024286;912.3750231091724;912.4844462878485;912.7489940266413;912.9634814607408;759.6695437484711;782.7729958312083;906.8458362078462;908.7864351877304;910.6493999810087;579.8869220502004;580.3500079910527;647.3364801078932;662.1359126340125;668.1914882991586;14033.508827190999;14036.929815350857;14063.2968351582;14079.648008799759;14086.71826563463;13934.233617151052;14047;14117.64705882351;14127.232967537702;14259.643508912257;12115.878841211563;12250.264984100893;12261.386930653433;12325.5069797208;12338.876611233862;4214.557471465482;4253.425787518708;4266.445362102938;4327;4335.588119128678;60509.69745151246;60556.39443605552;60744.392556074316;62518;62963.6851815738;10971.890281097247;10996.450177491093;11240.943795281135;11254.831177532344;11528.365939873387;19624.509387265432;19641.214351426068;19657;19658.50853728668;19680.311189108314;7709.730159444504;7823.139454659983;7919.049714034353;8145;8222.876656850152;4496.64026877849;4517.6837621366185;4545.749983750926;4614.7461889595725;4621.792019359137;3206.64726880043;3256.739460843127;3313.6520665330277;3320.5351250824906;3351.0617027232415;577.4543056811273;587.2835141127817;606.8604221029188;613.141601757543;657.5857209957696;676.681959479044;759.7075126076389;778.3111945927894;783.7296132834163;795.8965334506477;9482.620695172254;9636.614535418505;9768.90231097694;9790.608375665037;10049.346792458467;606.254307202135;623.1369553168894;626.1234272019119;644.7678835619173;728.0498948871773;4609.492955774862;4845.079434907357;4892.828750993698;5043.36957880265;5092.10888094582;74140;84850.57574712086;86046;87111.56444217739;87825;51161;74543;74647.62676186692;75600.24399756042;75841.6207918957;67426.66286668535;68801.65599172072;68963;71447.28552714406;71842.28157718356;9859.556319965763;10010.799784004133;10141.949290253502;10220.591176352862;10256.846147307648;47096;47323.76338118287;47867.52132478631;48275;49579;65221;67266;67445;67816.66091669707;68388.65805670939;13054.412551435018;13061.477540898257;13247.403866825824;13249.205047697169;13515.459381624625;15185.696286074437;15356;15366.154861482726;15607.141607211712;16070.116143612213;13203.471861125447;13280.667983300495;13297.534586289434;13521.459141634225;13536.661583460493;12829.21504416019;12988.155769875306;13012.934935325262;13056.477740890638;13070.411831467796;14014.859851401356;14096.36566354537;14176.929115354356;14322.212278324792;15086.24568771579;11555;11571.537138514364;12034.338111403607;12282.385880706108;12394.62816115518;11968.281903085843;12141.453634586642;12302.753944920873;12567.811482827581;12584.748305033665 08:50:13 INFO - PROCESS | 9847 | __end_tp_report 08:50:13 INFO - PROCESS | 9847 | __start_cc_report 08:50:13 INFO - PROCESS | 9847 | _x_x_mozilla_cycle_collect,1067 08:50:13 INFO - PROCESS | 9847 | __end_cc_report 08:50:13 INFO - PROCESS | 9847 | __startTimestamp1484585413717__endTimestamp 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | ------- Summary: start ------- 08:50:13 INFO - PROCESS | 9847 | Number of tests: 6 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | [#0] dojo.html Cycles:165 Average:5452.06 Median:5603.41 stddev:599.40 (10.7%) stddev-sans-first:574.15 08:50:13 INFO - PROCESS | 9847 | Values: 3180.7 3222.4 3223.6 3224.9 3251.8 5381.7 5480.8 5500.6 5502.3 5508.6 5554.7 5566.4 5567.9 5572.1 5602.5 5014.3 5044.0 5060.7 5073.5 5121.1 4862.2 5065.2 5117.2 5118.5 5146.0 4841.9 4928.1 4977.9 5020.2 5026.9 5043.7 5061.5 5126.2 5129.7 5154.0 4785.6 5015.9 5038.8 5069.8 5099.4 5346.8 5364.1 5414.8 5427.4 5446.4 5832.5 5851.0 5952.5 5959.9 5972.0 5647.6 5692.8 5993.6 5998.3 6010.2 5469.7 5536.4 5541.6 5564.2 5598.1 6101.3 6104.4 6108.2 6111.3 6120.8 5542.2 5584.9 5852.3 5856.5 5860.4 5729.9 5800.0 5817.1 5854.6 5885.9 5810.9 5813.0 5815.8 5816.7 5852.2 5669.5 5752.2 5794.2 5816.4 5817.7 4435.8 4515.0 4546.8 4562.5 4627.4 4086.3 4093.3 4099.8 4106.4 4108.4 5369.7 5640.2 5646.5 5656.0 5677.7 5705.0 5729.1 5734.5 5747.5 5873.4 5515.0 5521.3 5524.9 5525.1 5525.5 5056.5 5069.5 5070.6 5070.9 5102.2 5867.5 5923.9 6045.7 6130.8 6139.2 5945.8 5970.9 5970.9 5974.9 5984.2 6125.4 6195.4 6196.0 6199.0 6201.5 5500.1 5586.4 5617.9 5662.5 5822.2 5733.2 5757.4 5759.6 5766.1 5771.3 5626.6 5627.4 5630.1 5635.5 5639.9 5553.6 5556.0 5589.0 5601.7 5603.4 5672.3 5729.0 5745.9 5777.4 5784.3 5800.9 5842.3 5851.2 5857.5 5863.5 5368.3 5368.4 5554.4 5628.6 5699.6 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | [#1] ext.html Cycles:180 Average:66172.48 Median:22531.11 stddev:135423.09 (601.0%) stddev-sans-first:135713.43 08:50:13 INFO - PROCESS | 9847 | Values: 578.7 630.0 646.9 655.4 660.4 34422.5 37577.1 37839.8 45876.0 47421.0 47613.0 48038.3 48046.3 48067.0 48128.8 8839.8 8989.6 8991.1 8993.9 9006.0 8479.2 8660.7 8669.7 8946.0 10610.4 10673.8 11000.8 11001.2 11016.1 11020.6 10825.2 10832.0 10878.8 10894.2 10898.3 10747.6 10784.9 10808.6 10814.5 10822.7 44865.8 45187.1 45210.1 45217.0 45260.8 3528.7 3738.8 3759.1 3960.5 4112.4 34231.0 34434.1 34815.0 36500.3 36605.0 4511.3 4537.6 4578.2 4620.1 4757.6 333252.0 336787.0 338620.0 339172.0 339610.0 64051.0 64280.7 64334.0 64354.7 64377.0 39423.8 40940.2 40949.8 43692.6 43728.6 17012.3 17229.0 17237.2 17247.6 17248.7 12483.8 12568.3 12620.2 12635.1 12696.2 18910.3 19537.8 20287.8 21144.0 21147.5 7076.3 7201.7 7218.5 7340.5 7408.7 1007.7 1043.4 1084.0 1114.9 1153.6 35082.6 35528.6 35584.0 35618.3 35627.5 1127.9 1153.1 1166.3 1174.8 1220.7 18341.5 18490.0 18607.2 18751.9 18761.9 539110.0 547732.0 548800.0 550250.0 550270.0 54878.2 56138.7 59573.7 61854.7 61983.7 1374.7 1392.3 1416.6 1416.7 1417.0 33139.5 35165.5 35314.6 35879.3 36034.0 56416.2 56752.7 56901.0 56910.7 56934.0 493971.0 506643.0 511828.0 724328.0 726851.0 47150.3 47345.0 47530.8 47633.0 47780.0 51828.5 51844.2 52153.3 53032.0 53114.0 43943.6 44975.6 45048.3 45395.0 46860.3 44040.6 44690.1 45460.0 45886.3 46293.5 44019.1 44265.3 44543.0 44992.0 45158.3 36242.8 39240.2 39419.2 39546.4 39999.4 30013.8 30205.7 30383.2 30463.5 30571.2 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | [#2] jquery.html Cycles:180 Average:30187.67 Median:11419.04 stddev:84307.09 (738.3%) stddev-sans-first:84513.90 08:50:13 INFO - PROCESS | 9847 | Values: 389.2 414.2 423.8 424.0 428.2 16707.9 19110.3 19589.5 19692.5 20182.3 19722.5 19842.8 19865.1 19909.8 20032.0 5236.6 5523.9 5760.9 6402.8 6452.0 6480.5 6482.1 6532.9 6557.4 6559.3 6183.1 6295.8 6299.1 6301.3 6416.3 5681.7 5866.5 6380.4 6398.3 6407.8 5860.7 5868.1 5871.7 5874.1 5878.7 13610.2 22559.3 23302.3 23450.5 24439.3 2253.6 2445.7 2479.6 2797.8 2932.9 11302.7 11398.2 11475.4 14542.1 14931.8 1865.6 1921.4 1945.7 1961.4 2031.5 58738.0 74949.6 75468.0 82026.0 83203.6 11820.0 11899.9 11932.3 11984.8 12006.7 16658.8 16714.5 16718.0 16753.7 16777.8 8327.6 8354.8 8391.4 8533.7 8597.5 7856.8 7860.4 7894.5 8114.8 8115.4 4974.8 5110.8 5125.6 5136.3 5276.8 1851.2 2009.4 2045.9 2091.0 2146.1 1026.8 1036.5 1051.6 1070.2 1109.9 20230.3 20311.9 20369.9 20448.4 20792.2 986.6 1021.0 1022.4 1097.8 1109.9 10640.4 11517.9 11543.1 11701.4 11705.9 494192.0 511099.0 513287.0 514499.0 522489.0 95813.0 105252.5 105278.0 106074.0 107243.0 1006.7 1014.9 1043.8 1055.0 1057.0 17807.0 18200.7 18536.3 18683.8 18991.5 31752.2 43018.4 43999.7 44240.1 44696.3 56518.2 60366.0 60783.7 61931.0 62963.4 8675.9 9210.9 9244.2 9346.5 9528.8 10970.5 13709.4 13766.3 13989.5 13998.6 11615.6 12074.6 12091.2 12376.9 12432.1 11891.7 12083.1 12374.8 12470.7 12514.2 11639.7 12366.9 12374.2 12621.4 12715.2 8778.7 8994.4 9048.4 9164.6 9355.6 11166.7 12240.9 12253.6 12284.6 12304.2 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | [#3] mootools.html Cycles:180 Average:5580.46 Median:5086.20 stddev:3048.02 (59.9%) stddev-sans-first:3040.76 08:50:13 INFO - PROCESS | 9847 | Values: 1449.9 1488.7 1628.9 1735.2 1783.4 7878.4 8384.8 8401.8 8402.5 8407.7 7296.8 7477.9 8127.6 8312.9 8320.6 2416.0 2433.6 2442.9 2444.6 2444.9 2426.6 2434.2 2452.5 2456.9 2457.8 2387.8 2390.4 2417.0 2420.6 2422.8 2342.5 2344.2 2368.5 2369.1 2370.7 2336.5 2366.5 2394.3 2400.4 2403.3 8447.7 8493.9 8499.2 8503.3 8508.3 5217.8 5347.8 5352.0 5356.0 5358.4 3322.1 3332.1 3364.1 3367.1 3429.3 1158.2 1168.6 1172.5 1181.6 1201.6 11158.8 11186.5 11237.5 11240.8 11257.5 4303.9 4473.4 4528.2 4567.0 4571.1 9306.7 9317.7 9320.3 9337.5 9351.3 5243.5 5246.9 5251.2 5252.1 5261.7 4280.6 4353.4 4509.6 4890.7 4929.9 3838.6 3864.2 3908.6 3952.5 3959.2 1195.1 1199.6 1204.6 1205.6 1214.9 888.6 1015.8 1018.4 1023.8 1031.4 5749.8 5842.1 5863.1 5968.1 6017.8 492.4 493.0 493.7 1020.4 1042.6 3867.8 4105.0 4175.5 4197.7 4278.0 10089.9 10570.6 10573.2 10576.9 10590.5 10452.5 10452.6 10463.0 10464.7 10525.2 8035.8 8227.8 8242.9 8244.5 8249.9 5673.6 5937.8 6056.7 6086.4 6088.1 9385.2 9536.7 9606.4 9629.4 9657.5 9749.2 9752.0 9760.4 9767.0 9888.6 6770.9 6889.0 6922.1 7535.8 7685.3 7815.5 8062.7 8125.5 8130.8 8143.6 7110.7 7208.9 7220.9 7245.9 7306.2 6904.3 6959.8 6978.6 7026.4 7095.1 6526.5 6656.6 6658.4 6658.4 6661.4 4968.2 5029.4 5143.0 5179.6 5181.0 5275.8 5297.4 5403.6 5413.6 5427.8 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | [#4] prototype.html Cycles:180 Average:4754.34 Median:5385.10 stddev:1388.32 (25.8%) stddev-sans-first:1352.28 08:50:13 INFO - PROCESS | 9847 | Values: 349.8 352.5 353.1 358.8 359.4 5440.5 5442.2 5472.6 5484.3 5495.6 5372.4 5379.4 5390.8 5395.3 5411.6 3719.0 4011.5 4077.5 4115.6 4199.4 4226.4 4226.7 4227.6 4243.4 4265.3 4240.5 4241.8 4242.8 4248.2 4253.9 4084.6 4131.3 4199.7 4250.2 4252.2 3757.2 3771.5 3775.6 3777.5 3793.2 5252.2 5281.6 5283.2 5287.6 5290.7 4751.3 4807.0 4826.1 4847.8 4866.0 5548.5 5593.7 5607.6 5612.6 5615.7 4107.7 4126.9 4132.9 4133.0 4138.3 5595.1 5739.4 5750.8 5810.2 5811.6 4223.5 4226.3 4229.7 4233.6 4234.3 4277.7 4280.0 4282.0 4282.8 4285.2 4644.0 4749.5 4750.7 4755.8 4832.7 5575.5 5591.9 5611.0 5617.8 5663.2 1412.2 1420.4 1420.7 1420.8 1433.4 967.4 1020.2 1023.7 1035.6 1043.7 5149.7 5236.9 5244.9 5264.5 5270.7 5564.1 5566.5 5584.4 5598.4 5599.8 5018.4 5226.2 5263.2 5267.3 5267.9 2942.6 2949.0 2955.2 2959.5 2966.7 5770.5 5788.7 5791.2 5793.8 5794.9 5621.1 5704.5 5933.5 5936.1 5947.2 5910.3 5935.4 6046.6 6084.9 6088.5 5832.3 5855.3 5861.7 5867.2 5876.7 5556.7 5704.1 5755.1 5770.4 5795.3 5998.3 6035.1 6050.2 6055.2 6097.4 4202.9 4203.5 4209.6 4211.6 4218.6 5605.1 5848.9 5857.9 5894.9 5906.2 5701.6 5703.8 5706.4 5723.9 5737.7 5531.6 5668.5 5699.5 5709.2 5733.6 5623.8 5628.7 5631.9 5635.3 5665.1 5727.7 5734.3 5757.8 5759.8 5770.0 5443.8 5542.9 5625.3 5625.8 5626.9 08:50:13 INFO - PROCESS | 9847 | 08:50:13 INFO - PROCESS | 9847 | [#5] yui.html Cycles:180 Average:17999.69 Median:25858.90 stddev:23070.41 (89.2%) stddev-sans-first:23098.88 08:50:13 INFO - PROCESS | 9847 | Values: 776.4 819.7 822.8 846.4 890.8 14484.2 15762.9 15947.0 16099.5 16228.7 14561.6 14751.7 14785.5 14904.2 14930.3 738.7 756.0 840.6 857.9 860.3 844.6 866.4 870.7 871.3 871.4 909.9 912.4 912.5 912.7 913.0 759.7 782.8 906.8 908.8 910.6 579.9 580.4 647.3 662.1 668.2 14033.5 14036.9 14063.3 14079.6 14086.7 13934.2 14047.0 14117.6 14127.2 14259.6 12115.9 12250.3 12261.4 12325.5 12338.9 4214.6 4253.4 4266.4 4327.0 4335.6 60509.7 60556.4 60744.4 62518.0 62963.7 10971.9 10996.5 11240.9 11254.8 11528.4 19624.5 19641.2 19657.0 19658.5 19680.3 7709.7 7823.1 7919.0 8145.0 8222.9 4496.6 4517.7 4545.7 4614.7 4621.8 3206.6 3256.7 3313.7 3320.5 3351.1 577.5 587.3 606.9 613.1 657.6 676.7 759.7 778.3 783.7 795.9 9482.6 9636.6 9768.9 9790.6 10049.3 606.3 623.1 626.1 644.8 728.0 4609.5 4845.1 4892.8 5043.4 5092.1 74140.0 84850.6 86046.0 87111.6 87825.0 51161.0 74543.0 74647.6 75600.2 75841.6 67426.7 68801.7 68963.0 71447.3 71842.3 9859.6 10010.8 10141.9 10220.6 10256.8 47096.0 47323.8 47867.5 48275.0 49579.0 65221.0 67266.0 67445.0 67816.7 68388.7 13054.4 13061.5 13247.4 13249.2 13515.5 15185.7 15356.0 15366.2 15607.1 16070.1 13203.5 13280.7 13297.5 13521.5 13536.7 12829.2 12988.2 13012.9 13056.5 13070.4 14014.9 14096.4 14176.9 14322.2 15086.2 11555.0 11571.5 12034.3 12282.4 12394.6 11968.3 12141.5 12302.8 12567.8 12584.7 08:50:13 INFO - PROCESS | 9847 | -------- Summary: end -------- 08:50:13 INFO - PROCESS | 9847 | 08:50:14 INFO - TEST-INFO | 9847: exit 0 08:50:14 INFO - TEST-OK | dromaeo_css | took 1115023ms 08:50:14 INFO - TEST-START | kraken 08:50:14 INFO - operating with platform_type : linux_ 08:50:14 INFO - Initialising browser for kraken test... 08:50:14 INFO - TEST-INFO | started process 10170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Fiw9g/profile http://localhost:45176/getInfo.html) 08:50:18 INFO - PROCESS | 10170 | __metrics Screen width/height:1600/1200 08:50:18 INFO - PROCESS | 10170 | colorDepth:24 08:50:18 INFO - PROCESS | 10170 | Browser inner width/height: 1024/697 08:50:18 INFO - PROCESS | 10170 | __metrics 08:50:19 INFO - PROCESS | 10170 | 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:50:19 INFO - PROCESS | 10170 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:19 INFO - PROCESS | 10170 | console.error: PushService: 08:50:19 INFO - PROCESS | 10170 | stateChangeProcessEnqueue: Error transitioning state 08:50:19 INFO - PROCESS | 10170 | UnknownError 08:50:20 INFO - TEST-INFO | 10170: exit 0 08:50:20 INFO - Browser initialized. 08:50:20 INFO - Running cycle 1/1 for kraken test... 08:50:20 INFO - TEST-INFO | started process 10263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Fiw9g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:31 INFO - PROCESS | 10263 | RSS: Main: 144109568 08:50:31 INFO - PROCESS | 10263 | 08:50:34 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45176/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:35 INFO - PROCESS | 10263 | RSS: Main: 185827328 08:50:35 INFO - PROCESS | 10263 | 08:50:37 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45176/tests/kraken/driver.html?testName=audio-dft) 08:50:38 INFO - PROCESS | 10263 | RSS: Main: 174985216 08:50:38 INFO - PROCESS | 10263 | 08:50:41 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45176/tests/kraken/driver.html?testName=audio-fft) 08:50:41 INFO - PROCESS | 10263 | RSS: Main: 266219520 08:50:41 INFO - PROCESS | 10263 | 08:50:43 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45176/tests/kraken/driver.html?testName=audio-oscillator) 08:50:44 INFO - PROCESS | 10263 | RSS: Main: 172584960 08:50:44 INFO - PROCESS | 10263 | 08:50:46 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45176/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:50:47 INFO - PROCESS | 10263 | RSS: Main: 175239168 08:50:47 INFO - PROCESS | 10263 | 08:50:50 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45176/tests/kraken/driver.html?testName=imaging-darkroom) 08:50:50 INFO - PROCESS | 10263 | RSS: Main: 214695936 08:50:50 INFO - PROCESS | 10263 | 08:50:54 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45176/tests/kraken/driver.html?testName=imaging-desaturate) 08:50:54 INFO - PROCESS | 10263 | RSS: Main: 212807680 08:50:54 INFO - PROCESS | 10263 | 08:50:57 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45176/tests/kraken/driver.html?testName=json-parse-financial) 08:50:57 INFO - PROCESS | 10263 | RSS: Main: 211152896 08:50:57 INFO - PROCESS | 10263 | 08:50:59 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45176/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:50:59 INFO - PROCESS | 10263 | RSS: Main: 173453312 08:50:59 INFO - PROCESS | 10263 | 08:51:01 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:02 INFO - PROCESS | 10263 | RSS: Main: 180604928 08:51:02 INFO - PROCESS | 10263 | 08:51:04 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:04 INFO - PROCESS | 10263 | RSS: Main: 189386752 08:51:04 INFO - PROCESS | 10263 | 08:51:07 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:08 INFO - PROCESS | 10263 | RSS: Main: 193531904 08:51:08 INFO - PROCESS | 10263 | 08:51:10 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:11 INFO - PROCESS | 10263 | RSS: Main: 195080192 08:51:11 INFO - PROCESS | 10263 | 08:51:12 INFO - PROCESS | 10263 | Cycle 1(1): loaded http://localhost:45176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45176/tests/kraken/driver.html?testName=ai-astar) 08:51:13 INFO - PROCESS | 10263 | RSS: Main: 246349824 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | __start_tp_report 08:51:13 INFO - PROCESS | 10263 | _x_x_mozilla_page_load 08:51:13 INFO - PROCESS | 10263 | _x_x_mozilla_page_load_details 08:51:13 INFO - PROCESS | 10263 | |i|pagename|runs| 08:51:13 INFO - PROCESS | 10263 | |0;ai-astar;106;112;112;111;112;112;111;111;112;112 08:51:13 INFO - PROCESS | 10263 | |1;audio-beat-detection;145;118;119;158;118;120;119;122;147;118 08:51:13 INFO - PROCESS | 10263 | |2;audio-dft;161;160;160;160;161;161;160;161;162;161 08:51:13 INFO - PROCESS | 10263 | |3;audio-fft;76;75;76;119;77;75;75;76;101;76 08:51:13 INFO - PROCESS | 10263 | |4;audio-oscillator;81;82;124;82;82;81;97;82;82;115 08:51:13 INFO - PROCESS | 10263 | |5;imaging-gaussian-blur;116;116;117;116;116;117;117;116;117;116 08:51:13 INFO - PROCESS | 10263 | |6;imaging-darkroom;147;148;147;146;146;147;148;147;147;146 08:51:13 INFO - PROCESS | 10263 | |7;imaging-desaturate;85;84;84;85;84;85;84;84;85;85 08:51:13 INFO - PROCESS | 10263 | |8;json-parse-financial;49;49;50;51;50;50;52;50;50;49 08:51:13 INFO - PROCESS | 10263 | |9;json-stringify-tinderbox;59;60;59;60;59;59;60;59;60;60 08:51:13 INFO - PROCESS | 10263 | |10;stanford-crypto-aes;77;80;73;74;74;74;76;74;73;74 08:51:13 INFO - PROCESS | 10263 | |11;stanford-crypto-ccm;133;122;123;129;128;121;123;119;187;131 08:51:13 INFO - PROCESS | 10263 | |12;stanford-crypto-pbkdf2;153;154;152;152;153;150;152;152;150;152 08:51:13 INFO - PROCESS | 10263 | |13;stanford-crypto-sha256-iterative;63;61;61;62;62;60;63;61;62;60 08:51:13 INFO - PROCESS | 10263 | __end_tp_report 08:51:13 INFO - PROCESS | 10263 | __start_cc_report 08:51:13 INFO - PROCESS | 10263 | _x_x_mozilla_cycle_collect,1583 08:51:13 INFO - PROCESS | 10263 | __end_cc_report 08:51:13 INFO - PROCESS | 10263 | __startTimestamp1484585473221__endTimestamp 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | ------- Summary: start ------- 08:51:13 INFO - PROCESS | 10263 | Number of tests: 14 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:1.85 (1.7%) stddev-sans-first:0.50 08:51:13 INFO - PROCESS | 10263 | Values: 106.0 112.0 112.0 111.0 112.0 112.0 111.0 111.0 112.0 112.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:121.00 stddev:15.31 (12.7%) stddev-sans-first:15.02 08:51:13 INFO - PROCESS | 10263 | Values: 145.0 118.0 119.0 158.0 118.0 120.0 119.0 122.0 147.0 118.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 08:51:13 INFO - PROCESS | 10263 | Values: 161.0 160.0 160.0 160.0 161.0 161.0 160.0 161.0 162.0 161.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:15.06 (19.8%) stddev-sans-first:15.79 08:51:13 INFO - PROCESS | 10263 | Values: 76.0 75.0 76.0 119.0 77.0 75.0 75.0 76.0 101.0 76.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.00 stddev:16.01 (19.5%) stddev-sans-first:16.58 08:51:13 INFO - PROCESS | 10263 | Values: 81.0 82.0 124.0 82.0 82.0 81.0 97.0 82.0 82.0 115.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:51:13 INFO - PROCESS | 10263 | Values: 116.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:51:13 INFO - PROCESS | 10263 | Values: 147.0 148.0 147.0 146.0 146.0 147.0 148.0 147.0 147.0 146.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:51:13 INFO - PROCESS | 10263 | Values: 85.0 84.0 84.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.94 (1.9%) stddev-sans-first:0.93 08:51:13 INFO - PROCESS | 10263 | Values: 49.0 49.0 50.0 51.0 50.0 50.0 52.0 50.0 50.0 49.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 08:51:13 INFO - PROCESS | 10263 | Values: 59.0 60.0 59.0 60.0 59.0 59.0 60.0 59.0 60.0 60.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.18 (3.0%) stddev-sans-first:2.18 08:51:13 INFO - PROCESS | 10263 | Values: 77.0 80.0 73.0 74.0 74.0 74.0 76.0 74.0 73.0 74.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:128.50 stddev:20.01 (15.6%) stddev-sans-first:21.21 08:51:13 INFO - PROCESS | 10263 | Values: 133.0 122.0 123.0 129.0 128.0 121.0 123.0 119.0 187.0 131.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:152.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 08:51:13 INFO - PROCESS | 10263 | Values: 153.0 154.0 152.0 152.0 153.0 150.0 152.0 152.0 150.0 152.0 08:51:13 INFO - PROCESS | 10263 | 08:51:13 INFO - PROCESS | 10263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.08 (1.7%) stddev-sans-first:1.00 08:51:13 INFO - PROCESS | 10263 | Values: 63.0 61.0 61.0 62.0 62.0 60.0 63.0 61.0 62.0 60.0 08:51:13 INFO - PROCESS | 10263 | -------- Summary: end -------- 08:51:13 INFO - PROCESS | 10263 | 08:51:14 INFO - TEST-INFO | 10263: exit 0 08:51:14 INFO - TEST-OK | kraken | took 59898ms 08:51:14 INFO - SUITE-END | took 1174s 08:51:14 INFO - Completed test suite (00:19:34) 08:51:14 INFO - javascript benchmark 08:51:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3180.7137357637816, 3222.3716375306794, 3223.629282632498, 3224.85488153033, 3251.7561182911286, 5381.677099374036, 5480.7533660985255, 5500.642458240217, 5502.284702988606, 5508.55931525478, 5554.666719996803, 5566.387697353288, 5567.916481252784, 5572.136318870572, 5602.467765562275, 5014.2979982802435, 5044.016416798726, 5060.6963582185, 5073.452596957926, 5121.129408000649, 4862.246351815475, 5065.214891691794, 5117.1556693145585, 5118.488151184889, 5146.0222557714105, 4841.903161936777, 4928.088303663816, 4977.900441991158, 5020.246962955549, 5026.899462010758, 5043.722595257278, 5061.54446099851, 5126.179811230185, 5129.6922184668665, 5153.974230128825, 4785.641076919245, 5015.899682006339, 5038.773255203488, 5069.822556210552, 5099.413567439755, 5346.759395827197, 5364.1149210380245, 5414.756335964891, 5427.43011983744, 5446.428125046853, 5832.475077243026, 5851.034579294412, 5952.523798096186, 5959.880802383971, 5972.0, 5647.576431767634, 5692.77228910843, 5993.640381577119, 5998.28020637522, 6010.218671572711, 5469.72651367434, 5536.446355364431, 5541.639793413416, 5564.19319198722, 5598.1322894951345, 6101.328853826076, 6104.38956104386, 6108.175396321529, 6111.297200821873, 6120.78577249803, 5542.196381524737, 5584.91622625661, 5852.326982396994, 5856.531477481792, 5860.443257890493, 5729.942700573024, 5800.01399762033, 5817.127430885401, 5854.619449735754, 5885.882282354329, 5810.854728631818, 5813.04084825999, 5815.767369305265, 5816.709164541756, 5852.239208902815, 5669.546436285087, 5752.223449834219, 5794.188813566104, 5816.447437493432, 5817.680027598438, 4435.756033418128, 4514.977425112854, 4546.818127274938, 4562.475315338778, 4627.3521706961055, 4086.2849001424634, 4093.324601440729, 4099.815508302134, 4106.384042393605, 4108.383742438598, 5369.704666243316, 5640.182173584807, 5646.520045796071, 5655.971720141373, 5677.659340439587, 5705.0, 5729.054705973551, 5734.455226753452, 5747.540196784247, 5873.442023007808, 5514.979728750194, 5521.309836270466, 5524.889502209933, 5525.088360420566, 5525.475079867406, 5056.544910957958, 5069.518395752398, 5070.645054846199, 5070.873228169252, 5102.2346648003095, 5867.530597552186, 5923.881522369528, 6045.697715114315, 6130.795626845359, 6139.171211886338, 5945.821625351074, 5970.850728731816, 5970.910436343545, 5974.910376344272, 5984.16221728967, 6125.356837531995, 6195.411435913581, 6195.977663685441, 6199.0, 6201.503879689704, 5500.119980803052, 5586.441355864381, 5617.859553511195, 5662.462066103713, 5822.2140011099655, 5733.197352370755, 5757.424257574209, 5759.568032397503, 5766.106253530709, 5771.307443106686, 5626.606137570331, 5627.43725627434, 5630.099184130683, 5635.464630860061, 5639.859003524781, 5553.555715542666, 5556.027695153412, 5589.0, 5601.691906945157, 5603.411641777555, 5672.262605861211, 5729.0, 5745.885082298414, 5777.422257774189, 5784.2769653793275, 5800.9419905800405, 5842.328132264844, 5851.239338885917, 5857.47282744555, 5863.530917526502, 5368.2752828367675, 5368.436314186954, 5554.361248456317, 5628.605997580294, 5699.629524080921], "value": 5413.362639000179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7424596054755, 629.9653519056451, 646.8673921846022, 655.3839390972486, 660.4485254812231, 34422.48366274508, 37577.06057348568, 37839.81080094599, 45876.0, 47421.0, 47613.0, 48038.279425808556, 48046.27930581044, 48067.0, 48128.759356203256, 8839.823203535942, 8989.640414383417, 8991.055939126396, 8993.865092023625, 9006.0, 8479.194476524752, 8660.653573857038, 8669.739907802776, 8945.95527022364, 10610.416427096507, 10673.78652426951, 11000.834987475195, 11001.1749118816, 11016.11871050314, 11020.559177632886, 10825.188110891715, 10831.970962758525, 10878.782424351548, 10894.237403381767, 10898.291611045297, 10747.570097196181, 10784.892151078546, 10808.621698240602, 10814.51334689933, 10822.729431764268, 44865.77567112144, 45187.096258074984, 45210.09579808386, 45217.0, 45260.77369613164, 3528.7177025837873, 3738.756980796267, 3759.0602349412648, 3960.485136932209, 4112.424260603518, 34231.0, 34434.139146521535, 34815.0, 36500.269994600225, 36605.0, 4511.323301504768, 4537.636989040869, 4578.198815207359, 4620.145273124483, 4757.643176761757, 333252.0, 336787.0, 338620.0, 339172.0, 339610.0, 64051.0, 64280.67859660765, 64334.0, 64354.678226608565, 64377.03434448487, 39423.802880985415, 40940.1811963759, 40949.79525102415, 43692.563074369486, 43728.56271437309, 17012.319507219574, 17229.0, 17237.224324905408, 17247.56881077983, 17248.741268880978, 12483.750324993449, 12568.30874301922, 12620.17968832023, 12635.115541911979, 12696.17474864131, 18910.338138165374, 19537.80462195388, 20287.79712202859, 21144.0, 21147.471313216985, 7076.292370762985, 7201.675924583406, 7218.530795498275, 7340.522866013692, 7408.740694075682, 1007.7279134633608, 1043.403592503471, 1083.983740243897, 1114.8773634900153, 1153.5789436855487, 35082.64917350845, 35528.61430043153, 35584.0, 35618.286285286034, 35627.4655880162, 1127.8984891359817, 1153.0717772193298, 1166.3002198680724, 1174.7826652069396, 1220.682622518134, 18341.54146146357, 18490.0, 18607.16267767954, 18751.90624046871, 18761.90619046896, 539110.0, 547732.0, 548800.0, 550250.0, 550270.0, 54878.17682734762, 56138.7193064032, 59573.702131489066, 61854.69072654698, 61983.690081549306, 1374.7387996280675, 1392.303848075962, 1416.5608661315025, 1416.7379034878581, 1416.9929150354183, 33139.50290745689, 35165.47251791276, 35314.646853531136, 35879.282414351044, 36034.0, 56416.15375769449, 56752.71623641856, 56901.0, 56910.71544642416, 56934.0, 493971.0, 506643.0, 511828.0, 724328.0, 726851.0, 47150.29274560816, 47345.0, 47530.76234618805, 47633.0, 47780.04439911252, 51828.48171518387, 51844.222336665734, 52153.30857174346, 53032.0, 53114.0, 43943.56056439522, 44975.550244498445, 45048.324275136554, 45395.0, 46860.29709554427, 44040.55959440365, 44690.106197876514, 45460.0, 45886.31170532378, 46293.53706462892, 44019.11961760811, 44265.33601996037, 44543.0, 44992.0, 45158.32262515999, 36242.81878590696, 39240.215195696495, 39419.2116157681, 39546.38438164015, 39999.400008999306, 30013.849930750206, 30205.69794302029, 30383.24041898882, 30463.543046854757, 30571.2357191072], "value": 21676.348359256353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.17494910789134, 414.1695899721057, 423.7859880760217, 423.99364009539863, 428.16935145817115, 16707.916460417695, 19110.331138410158, 19589.51026224345, 19692.507687307807, 20182.293619723314, 19722.506937326572, 19842.801571984277, 19865.106070226837, 19909.800901990977, 20032.0, 5236.581073514109, 5523.889522209553, 5760.913586296209, 6402.839929001789, 6451.967740161316, 6480.4815614750705, 6482.092507049017, 6532.902006469907, 6557.409833115019, 6559.3112723164095, 6183.134361189437, 6295.811125666238, 6299.0551417287315, 6301.306856245809, 6416.3262857400005, 5681.687507187103, 5866.501347385477, 6380.393862583047, 6398.29618741938, 6407.839804004914, 5860.677662728548, 5868.149118377854, 5871.735771890275, 5874.060150375919, 5878.676672782995, 13610.183388996691, 22559.323220303417, 23302.300930971927, 23450.530989380117, 24439.26682199537, 2253.5830871288863, 2445.7431969643285, 2479.566075936704, 2797.818141820775, 2932.8838034997825, 11302.660920172408, 11398.202125851194, 11475.426228688615, 14542.054766440147, 14931.776023359658, 1865.6362009408172, 1921.3947606503907, 1945.7373254610588, 1961.4311849563753, 2031.5022819409191, 58738.0, 74949.62525187393, 75468.0, 82026.0, 83203.58398208031, 11820.0, 11899.88100119005, 11932.28406295625, 11984.820227696591, 12006.699832504082, 16658.833411665728, 16714.498565043068, 16718.0, 16753.748693769605, 16777.832221677872, 8327.625941719549, 8354.791130221793, 8391.412601117863, 8533.701320453754, 8597.484150950962, 7856.84286314282, 7860.410469214832, 7894.526328420313, 8114.837703245902, 8115.431919765678, 4974.801007959641, 5110.821121260738, 5125.589952803767, 5136.306598609214, 5276.841694749163, 1851.231738828398, 2009.437357539862, 2045.9106748809108, 2090.989545052265, 2146.098638571804, 1026.8140050697102, 1036.5439206749006, 1051.64244156987, 1070.1545778834634, 1109.9223054386277, 20230.291939782037, 20311.898440507703, 20369.89815050945, 20448.36413086979, 20792.1683132673, 986.5954958466995, 1020.9948950255201, 1022.3508072374096, 1097.846301517788, 1109.8945600167972, 10640.361578305326, 11517.942410288062, 11543.134264930164, 11701.414929253504, 11705.941470292593, 494192.0, 511099.0, 513287.0, 514499.0, 522489.0, 95813.0, 105252.47373763235, 105278.0, 106074.0, 107243.0, 1006.6728313298061, 1014.91373233276, 1043.7599352148895, 1054.99472502637, 1056.963006294776, 17807.0, 18200.72698909491, 18536.25854965786, 18683.800311762887, 18991.525211869262, 31752.206194844388, 43018.35472467853, 43999.70121753802, 44240.11519769651, 44696.32955505605, 56518.15222771579, 60366.0, 60783.69608151931, 61931.0, 62963.37036629575, 8675.91324086751, 9210.907890921006, 9244.168024877794, 9346.485943273185, 9528.809423811623, 10970.506327215135, 13709.423416306854, 13766.31168441594, 13989.510367137102, 13998.580042598738, 11615.5934542294, 12074.637760867188, 12091.15361924692, 12376.938115309726, 12432.12975091735, 11891.702707432383, 12083.093767967262, 12374.81437778416, 12470.688232794253, 12514.249145051326, 11639.6508104757, 12366.876331236572, 12374.195677280948, 12621.368931553568, 12715.237085774883, 8778.736637900873, 8994.370394072614, 9048.366614336934, 9164.587593558172, 9355.625774968925, 11166.720831979266, 12240.87759122433, 12253.632391027926, 12284.631461056182, 12304.200226985216], "value": 9688.56406778281, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.8912581556385, 1488.6576087499875, 1628.9429869954554, 1735.2191513818784, 1783.4382169616579, 7878.409119316053, 8384.790380240482, 8401.83196336073, 8402.49585024899, 8407.747767566967, 7296.817579560514, 7477.850442991151, 8127.634256458458, 8312.8753068704, 8320.583970801466, 2416.03358656537, 2433.634954756783, 2442.8778561071877, 2444.608862581987, 2444.9388765280833, 2426.611742121261, 2434.184548176363, 2452.5462789383932, 2456.8648724320155, 2457.8033757299463, 2387.7970372518357, 2390.4262976885598, 2416.9516609667794, 2420.636904464327, 2422.769836865495, 2342.543204075206, 2344.2146880794953, 2368.4789346343864, 2369.111583156325, 2370.656254843038, 2336.5326934613145, 2366.479374537599, 2394.31761947844, 2400.447896983686, 2403.267003563912, 8447.662093516252, 8493.915060849436, 8499.192576705203, 8503.319734421293, 8508.276796472308, 5217.791288348461, 5347.812826551052, 5352.0, 5356.035913535601, 5358.4373640767935, 3322.0864262328055, 3332.067021234034, 3364.0748794081824, 3367.1245476176127, 3429.3141371725505, 1158.154547180563, 1168.5968340922368, 1172.5016867831137, 1181.5628217559558, 1201.585453018707, 11158.776824463546, 11186.496607652674, 11237.494312755945, 11240.775184496264, 11257.493412796444, 4303.913921721548, 4473.351364052194, 4528.230200865861, 4567.018091110427, 4571.085782843445, 9306.72079837606, 9317.72046838596, 9320.254379649612, 9337.486438245962, 9351.345405821527, 5243.528082472596, 5246.868828279247, 5251.212318152231, 5252.05463016653, 5261.657992230493, 4280.571942805695, 4353.36876152956, 4509.594136527729, 4890.657653964259, 4929.852104436801, 3838.616138386195, 3864.2271545690974, 3908.6482216600643, 3952.505936757905, 3959.208158368338, 1195.0678470792795, 1199.6221190325193, 1204.644629834201, 1205.6202296276645, 1214.8967337776212, 888.5868071346855, 1015.827309357411, 1018.4144117132678, 1023.8413045977885, 1031.4275577054657, 5749.798757043483, 5842.065269556935, 5863.149843272701, 5968.134620480006, 6017.789377371859, 492.396813902966, 493.0262731106109, 493.74588545095054, 1020.357174979758, 1042.635077722791, 3867.806609669505, 4104.979475102606, 4175.519815221228, 4197.685173611992, 4277.957220427818, 10089.949550252202, 10570.577176912991, 10573.154147668169, 10576.947115264375, 10590.523426445829, 10452.477376131163, 10452.581896724198, 10463.0, 10464.738381540523, 10525.157987360994, 8035.839283214303, 8227.753167404988, 8242.876356854653, 8244.505329680238, 8249.917500825035, 5673.602847800615, 5937.762489500372, 6056.697165141637, 6086.391360863879, 6088.117223002551, 9385.155336019518, 9536.666216682383, 9606.375585586915, 9629.374090684083, 9657.517124143624, 9749.22006239485, 9752.024797520191, 9760.365576237522, 9767.023297670175, 9888.604455821687, 6770.898436523555, 6889.0, 6922.10012698346, 7535.849283014419, 7685.346745526693, 7815.53106813593, 8062.717804876801, 8125.512469251864, 8130.796730081795, 8143.552104634302, 7110.680019399036, 7208.855822883408, 7220.927790722026, 7245.891311630435, 7306.159791624032, 6904.344087311697, 6959.826004349932, 6978.581285122909, 7026.402755765817, 7095.148582169966, 6526.477881769542, 6656.600603963778, 6658.3674550917585, 6658.434033107046, 6661.4337781287195, 4968.205087186033, 5029.4216165140015, 5142.97428512855, 5179.559737422362, 5181.0, 5275.762590683506, 5297.364316282071, 5403.604392106926, 5413.621046526705, 5427.755750991136], "value": 4515.571195824735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8425708431206, 352.5293732866623, 353.14186526740025, 358.7524608020464, 359.4285086712129, 5440.455954404558, 5442.156465747816, 5472.616916815825, 5484.28704268445, 5495.587830912687, 5372.355317361922, 5379.408265090837, 5390.7870729085935, 5395.325584301962, 5411.592985823685, 3718.9814050929845, 4011.5386730525925, 4077.5106987161435, 4115.629593336599, 4199.4120823084795, 4226.366045093245, 4226.72526285792, 4227.556106608808, 4243.429930925547, 4265.296226122686, 4240.469941257343, 4241.830326786925, 4242.83028678854, 4248.192843359767, 4253.914921701564, 4084.590816168432, 4131.318332475138, 4199.748015119103, 4250.213710463574, 4252.170826688797, 3757.210985693008, 3771.4531392948143, 3775.565809931838, 3777.5089238399105, 3793.2413517296377, 5252.159654455307, 5281.603879708999, 5283.154695248781, 5287.603429742785, 5290.724988255049, 4751.31105989633, 4807.0, 4826.131296366688, 4847.806087756486, 4865.978144589641, 5548.529639645457, 5593.664380137164, 5607.57943154261, 5612.635178713412, 5615.66306021636, 4107.691923105779, 4126.938095928564, 4132.855350062763, 4133.0, 4138.317177665682, 5595.104783234704, 5739.426057394269, 5750.827475175752, 5810.24466819315, 5811.593188476851, 4223.4795473629465, 4226.274053235646, 4229.725067870579, 4233.618974292329, 4234.25900467417, 4277.668670574544, 4280.0369916769105, 4281.981203251762, 4282.807273672693, 4285.185814695198, 4643.95356046442, 4749.525047495292, 4750.667453278237, 4755.809767609326, 4832.661713680079, 5575.470330318613, 5591.860203494945, 5610.971945140248, 5617.831465055973, 5663.150527420919, 1412.2276542938546, 1420.3821337718125, 1420.6803469219342, 1420.8152940117718, 1433.426629348269, 967.4098799732158, 1020.1583693452783, 1023.7133602591286, 1035.6478797208986, 1043.6588983156607, 5149.716765577854, 5236.895262094813, 5244.895102098013, 5264.4996176089635, 5270.736463176902, 5564.081926482166, 5566.526845218121, 5584.357798853102, 5598.356189038313, 5599.832005039855, 5018.372703412074, 5226.189940559219, 5263.23683065961, 5267.31524901768, 5267.868303292448, 2942.646882374129, 2949.0, 2955.2168675301064, 2959.5412711029826, 2966.718161774628, 5770.480656740913, 5788.668606220509, 5791.160281759206, 5793.797217097465, 5794.884102318014, 5621.065254321991, 5704.543636509069, 5933.525317974551, 5936.1392598073035, 5947.167396564398, 5910.290765108214, 5935.376785437467, 6046.576739628272, 6084.90872636902, 6088.543359247986, 5832.270966129234, 5855.268091488564, 5861.706914654335, 5867.237259156283, 5876.676782776988, 5556.749946252347, 5704.087346024616, 5755.050416681201, 5770.422957704196, 5795.33353664334, 5998.25021872266, 6035.094735789667, 6050.213472248755, 6055.182550355822, 6097.359777223328, 4202.85290014848, 4203.537610862863, 4209.6000879916355, 4211.599898009684, 4218.55705150967, 5605.075162598288, 5848.912266316093, 5857.853553661193, 5894.882102358015, 5906.169087582863, 5701.629394089371, 5703.800366987136, 5706.372299047184, 5723.914141287801, 5737.713114344349, 5531.649049154174, 5668.5465162787705, 5699.544036477155, 5709.22925405065, 5733.569982251432, 5623.775048997994, 5628.690422026828, 5631.915521267102, 5635.267415235993, 5665.12190610456, 5727.713614319351, 5734.34055083654, 5757.769689212385, 5759.798407055733, 5769.9711501442225, 5443.8094666686475, 5542.944570554243, 5625.296837895263, 5625.803096891589, 5626.915596266142], "value": 4319.014957369695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.3788968824942, 819.71719756684, 822.8313195794861, 846.4117438380324, 890.799570096728, 14484.203368814724, 15762.92118539407, 15947.043177409363, 16099.517014489555, 16228.675426491478, 14561.563153105397, 14751.704965900675, 14785.482508112218, 14904.180270085168, 14930.328135233913, 738.6528331684127, 755.9924400756005, 840.6427268410916, 857.8756080368343, 860.3289434241302, 844.5734903873536, 866.4324867211986, 870.6691457246237, 871.298604623278, 871.376965469689, 909.8908131024286, 912.3750231091724, 912.4844462878485, 912.7489940266413, 912.9634814607408, 759.6695437484711, 782.7729958312083, 906.8458362078462, 908.7864351877304, 910.6493999810087, 579.8869220502004, 580.3500079910527, 647.3364801078932, 662.1359126340125, 668.1914882991586, 14033.508827190999, 14036.929815350857, 14063.2968351582, 14079.648008799759, 14086.71826563463, 13934.233617151052, 14047.0, 14117.64705882351, 14127.232967537702, 14259.643508912257, 12115.878841211563, 12250.264984100893, 12261.386930653433, 12325.5069797208, 12338.876611233862, 4214.557471465482, 4253.425787518708, 4266.445362102938, 4327.0, 4335.588119128678, 60509.69745151246, 60556.39443605552, 60744.392556074316, 62518.0, 62963.6851815738, 10971.890281097247, 10996.450177491093, 11240.943795281135, 11254.831177532344, 11528.365939873387, 19624.509387265432, 19641.214351426068, 19657.0, 19658.50853728668, 19680.311189108314, 7709.730159444504, 7823.139454659983, 7919.049714034353, 8145.0, 8222.876656850152, 4496.64026877849, 4517.6837621366185, 4545.749983750926, 4614.7461889595725, 4621.792019359137, 3206.64726880043, 3256.739460843127, 3313.6520665330277, 3320.5351250824906, 3351.0617027232415, 577.4543056811273, 587.2835141127817, 606.8604221029188, 613.141601757543, 657.5857209957696, 676.681959479044, 759.7075126076389, 778.3111945927894, 783.7296132834163, 795.8965334506477, 9482.620695172254, 9636.614535418505, 9768.90231097694, 9790.608375665037, 10049.346792458467, 606.254307202135, 623.1369553168894, 626.1234272019119, 644.7678835619173, 728.0498948871773, 4609.492955774862, 4845.079434907357, 4892.828750993698, 5043.36957880265, 5092.10888094582, 74140.0, 84850.57574712086, 86046.0, 87111.56444217739, 87825.0, 51161.0, 74543.0, 74647.62676186692, 75600.24399756042, 75841.6207918957, 67426.66286668535, 68801.65599172072, 68963.0, 71447.28552714406, 71842.28157718356, 9859.556319965763, 10010.799784004133, 10141.949290253502, 10220.591176352862, 10256.846147307648, 47096.0, 47323.76338118287, 47867.52132478631, 48275.0, 49579.0, 65221.0, 67266.0, 67445.0, 67816.66091669707, 68388.65805670939, 13054.412551435018, 13061.477540898257, 13247.403866825824, 13249.205047697169, 13515.459381624625, 15185.696286074437, 15356.0, 15366.154861482726, 15607.141607211712, 16070.116143612213, 13203.471861125447, 13280.667983300495, 13297.534586289434, 13521.459141634225, 13536.661583460493, 12829.21504416019, 12988.155769875306, 13012.934935325262, 13056.477740890638, 13070.411831467796, 14014.859851401356, 14096.36566354537, 14176.929115354356, 14322.212278324792, 15086.24568771579, 11555.0, 11571.537138514364, 12034.338111403607, 12282.385880706108, 12394.62816115518, 11968.281903085843, 12141.453634586642, 12302.753944920873, 12567.811482827581, 12584.748305033665], "value": 7360.121495211888, "unit": "score"}], "name": "dromaeo_css", "value": 7392.4868610735375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 119.0, 158.0, 118.0, 120.0, 119.0, 122.0, 147.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 119.0, 77.0, 75.0, 75.0, 76.0, 101.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 124.0, 82.0, 82.0, 81.0, 97.0, 82.0, 82.0, 115.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 51.0, 50.0, 50.0, 52.0, 50.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 73.0, 74.0, 74.0, 74.0, 76.0, 74.0, 73.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 123.0, 129.0, 128.0, 121.0, 123.0, 119.0, 187.0, 131.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 152.0, 152.0, 153.0, 150.0, 152.0, 152.0, 150.0, 152.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 62.0, 60.0, 63.0, 61.0, 62.0, 60.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1450.8999999999999, "alertThreshold": 2.0}]} 08:51:14 INFO - Return code: 0 08:51:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:51:14 INFO - # TBPL SUCCESS # 08:51:14 INFO - Running post-action listener: _resource_record_post_action 08:51:14 INFO - [mozharness: 2017-01-16 16:51:14.528193Z] Finished run-tests step (success) 08:51:14 INFO - Running post-run listener: _resource_record_post_run 08:51:14 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357580800; Read time: 16; Write time: 268256 08:51:14 INFO - TinderboxPrint: CPU usage
13.0% 08:51:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:51:14 INFO - TinderboxPrint: I/O write bytes / time
357,580,800 / 268,256 08:51:14 INFO - TinderboxPrint: CPU idle
8,279.8 (87.0%) 08:51:14 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 08:51:14 INFO - TinderboxPrint: Swap in / out
0 / 0 08:51:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107765760; Read time: 0; Write time: 104100 08:51:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247566336; Read time: 16; Write time: 163848 08:51:15 INFO - Running post-run listener: _upload_blobber_files 08:51:15 INFO - Blob upload gear active. 08:51:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:51:15 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:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:51:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:51:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:51:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:16 INFO - (blobuploader) - INFO - Done attempting. 08:51:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:51:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:51:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:17 INFO - (blobuploader) - INFO - Done attempting. 08:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:20 INFO - (blobuploader) - INFO - Done attempting. 08:51:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:51:20 INFO - Return code: 0 08:51:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:51:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:51:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c79e1a0e22e06ddb1b46a3aabfe18121b367ba4d669614abf564c215d93936a32fb0e4dbf0ce3ef448cf0c78ffe3e541a5f8c04c73eda4e2fe3bc58d4b9e0a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b61534c4b9a127e2d5a65ab41c9561efc12e786956d22e36e79fa1d6354ef03020571101274e3b4577c9c035dc8b11af072c8d7ed5b6729935b3a91ba6d5db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/496f10e84e7500ebfe8329a3f074040f727378171c73932a61d9cfd65429f98ce9b22aa0b71222cbfab2b5e77279d3ace42523ff6625b8737f7e34f5078e3e80"} 08:51:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:51:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:51:20 INFO - Contents: 08:51:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c79e1a0e22e06ddb1b46a3aabfe18121b367ba4d669614abf564c215d93936a32fb0e4dbf0ce3ef448cf0c78ffe3e541a5f8c04c73eda4e2fe3bc58d4b9e0a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b61534c4b9a127e2d5a65ab41c9561efc12e786956d22e36e79fa1d6354ef03020571101274e3b4577c9c035dc8b11af072c8d7ed5b6729935b3a91ba6d5db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/496f10e84e7500ebfe8329a3f074040f727378171c73932a61d9cfd65429f98ce9b22aa0b71222cbfab2b5e77279d3ace42523ff6625b8737f7e34f5078e3e80"} 08:51:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:51:20 INFO - Copying logs to upload dir... 08:51:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:51:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.165515 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-16 08:51:19.318195) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 08:51:19.322013) ========= 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=c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c79e1a0e22e06ddb1b46a3aabfe18121b367ba4d669614abf564c215d93936a32fb0e4dbf0ce3ef448cf0c78ffe3e541a5f8c04c73eda4e2fe3bc58d4b9e0a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b61534c4b9a127e2d5a65ab41c9561efc12e786956d22e36e79fa1d6354ef03020571101274e3b4577c9c035dc8b11af072c8d7ed5b6729935b3a91ba6d5db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/496f10e84e7500ebfe8329a3f074040f727378171c73932a61d9cfd65429f98ce9b22aa0b71222cbfab2b5e77279d3ace42523ff6625b8737f7e34f5078e3e80"} build_url:https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/BbJmcy18Qqu4vvc-_f2Csg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c79e1a0e22e06ddb1b46a3aabfe18121b367ba4d669614abf564c215d93936a32fb0e4dbf0ce3ef448cf0c78ffe3e541a5f8c04c73eda4e2fe3bc58d4b9e0a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6b61534c4b9a127e2d5a65ab41c9561efc12e786956d22e36e79fa1d6354ef03020571101274e3b4577c9c035dc8b11af072c8d7ed5b6729935b3a91ba6d5db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/496f10e84e7500ebfe8329a3f074040f727378171c73932a61d9cfd65429f98ce9b22aa0b71222cbfab2b5e77279d3ace42523ff6625b8737f7e34f5078e3e80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 08:51:19.347390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:51:19.347713) ========= 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=c6927cf182745ad25b1d38b9000001fe-1484584242.370780-268339032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 08:51:19.430947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 08:51:19.431344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 08:51:19.431702) ========= ========= Total master_lag: 0.17 =========