builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1477513896.59 results: success (0) buildid: 20161026103002 builduid: 78c5e69d605846f58a6f15026853634c revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.588526) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.589026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.589305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.606180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.606623) ========= 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=826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 13:31:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-10-26 13:31:37 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.753489) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.753816) ========= 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=826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016890 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.803618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:36.803996) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --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=826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 13:31:37,505 truncating revision to first 12 chars 2016-10-26 13:31:37,505 Setting DEBUG logging. 2016-10-26 13:31:37,505 attempt 1/10 2016-10-26 13:31:37,505 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:31:37,850 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:37.460289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:37.460856) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:37.461472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:37.461860) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:31:37.474727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-26 13:31:37.475284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:31:38 INFO - MultiFileLogger online at 20161026 13:31:38 in /builds/slave/test 13:31:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:31:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:31:38 INFO - {'append_to_log': False, 13:31:38 INFO - 'base_work_dir': '/builds/slave/test', 13:31:38 INFO - 'blob_upload_branch': 'Firefox', 13:31:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:31:38 INFO - 'branch': 'Firefox', 13:31:38 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:38 INFO - 'config_files': ('talos/linux_config.py',), 13:31:38 INFO - 'default_actions': ('clobber', 13:31:38 INFO - 'read-buildbot-config', 13:31:38 INFO - 'download-and-extract', 13:31:38 INFO - 'populate-webroot', 13:31:38 INFO - 'create-virtualenv', 13:31:38 INFO - 'install', 13:31:38 INFO - 'run-tests'), 13:31:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:38 INFO - 'download_minidump_stackwalk': True, 13:31:38 INFO - 'download_symbols': 'ondemand', 13:31:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:38 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:38 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:38 INFO - 'installer_path': 'installer.exe', 13:31:38 INFO - 'log_level': 'info', 13:31:38 INFO - 'log_name': 'talos', 13:31:38 INFO - 'log_to_console': True, 13:31:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:31:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:31:38 INFO - 'opt_config_files': (), 13:31:38 INFO - 'pip_index': False, 13:31:38 INFO - 'sps_profile': False, 13:31:38 INFO - 'sps_profile_interval': 0, 13:31:38 INFO - 'suite': 'dromaeojs', 13:31:38 INFO - 'system_bits': '32', 13:31:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:38 INFO - 'title': 'talos-linux64-ix-052', 13:31:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:38 INFO - 'use_talos_json': True, 13:31:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:31:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:38 INFO - 'work_dir': 'build'} 13:31:38 INFO - [mozharness: 2016-10-26 20:31:38.276713Z] Running clobber step. 13:31:38 INFO - Running pre-action listener: _resource_record_pre_action 13:31:38 INFO - Running main action method: clobber 13:31:38 INFO - rmtree: /builds/slave/test/build 13:31:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:31:39 INFO - Running post-action listener: _resource_record_post_action 13:31:39 INFO - [mozharness: 2016-10-26 20:31:39.259576Z] Finished clobber step (success) 13:31:39 INFO - [mozharness: 2016-10-26 20:31:39.259674Z] Running read-buildbot-config step. 13:31:39 INFO - Running pre-action listener: _resource_record_pre_action 13:31:39 INFO - Running main action method: read_buildbot_config 13:31:39 INFO - Using buildbot properties: 13:31:39 INFO - { 13:31:39 INFO - "project": "", 13:31:39 INFO - "product": "firefox", 13:31:39 INFO - "script_repo_revision": "production", 13:31:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:31:39 INFO - "repository": "", 13:31:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:31:39 INFO - "buildid": "20161026103002", 13:31:39 INFO - "pgo_build": "True", 13:31:39 INFO - "basedir": "/builds/slave/test", 13:31:39 INFO - "buildnumber": 601, 13:31:39 INFO - "slavename": "talos-linux64-ix-052", 13:31:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:31:39 INFO - "platform": "ubuntu64_hw", 13:31:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:31:39 INFO - "branch": "mozilla-central", 13:31:39 INFO - "repo_path": "mozilla-central", 13:31:39 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:31:39 INFO - "stage_platform": "linux64-pgo", 13:31:39 INFO - "builduid": "78c5e69d605846f58a6f15026853634c", 13:31:39 INFO - "slavebuilddir": "test" 13:31:39 INFO - } 13:31:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:31:39 INFO - Running post-action listener: _resource_record_post_action 13:31:39 INFO - [mozharness: 2016-10-26 20:31:39.262104Z] Finished read-buildbot-config step (success) 13:31:39 INFO - [mozharness: 2016-10-26 20:31:39.262193Z] Running download-and-extract step. 13:31:39 INFO - Running pre-action listener: _resource_record_pre_action 13:31:39 INFO - Running main action method: download_and_extract 13:31:39 INFO - mkdir: /builds/slave/test/build/tests 13: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')]} 13:31:39 INFO - trying https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:31:39 INFO - Downloading https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:31:39 INFO - Downloaded 1361 bytes. 13:31:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:31:39 INFO - Using the following test package requirements: 13:31:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:31:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:31:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'jsshell-linux-x86_64.zip'], 13:31:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:31:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:31:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:31:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:31:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:31:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:31:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:31:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:31:39 INFO - Fetch https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:31:40 INFO - Http code: 200 13:31:40 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 13:31:40 INFO - x-amz-cf-id: L9v_jvITeTLljLrTIEqBtqd1FH6L-hSz6h7WSD-oF26rrldLn9WTqQ== 13:31:40 INFO - x-amz-version-id: U_0UZo97Kb630CjesuvHyECqWqofhPXQ 13:31:40 INFO - Expected file size: 22058358 13:31:40 INFO - Obtained file size: 22058358 13:31:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:31:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:31:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:31:45 INFO - Fetch https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:31:45 INFO - Http code: 200 13:31:45 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 13:31:45 INFO - x-amz-cf-id: G8cYY75QNFGsD6hnKhgBLL3mt8TE395ARCDQ3BQWd0rW5yzu-LtmKw== 13:31:45 INFO - x-amz-version-id: U_0UZo97Kb630CjesuvHyECqWqofhPXQ 13:31:45 INFO - Expected file size: 22058358 13:31:45 INFO - Obtained file size: 22058358 13:31:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:31:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:31:50 INFO - Fetch https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:31:51 INFO - Http code: 200 13:31:51 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 13:31:51 INFO - x-amz-cf-id: YevLfyFIg4AdwgrSyw_9nX1RTI4a3l0KKHi9FSEizHsLLJ5pi8j1kg== 13:31:51 INFO - x-amz-version-id: iIrxpwrloyib8J5uGYqi6PsPGVxDmjCd 13:31:51 INFO - Expected file size: 14409028 13:31:51 INFO - Obtained file size: 14409028 13:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:51 INFO - trying https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:31:51 INFO - Downloading https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:31:52 INFO - Downloaded 59462255 bytes. 13:31:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:31:52 INFO - mkdir: /builds/slave/test/properties 13:31:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:31:52 INFO - Writing to file /builds/slave/test/properties/build_url 13:31:52 INFO - Contents: 13:31:52 INFO - build_url:https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:31:53 INFO - Running post-action listener: _resource_record_post_action 13:31:53 INFO - Running post-action listener: set_extra_try_arguments 13:31:53 INFO - [mozharness: 2016-10-26 20:31:53.341694Z] Finished download-and-extract step (success) 13:31:53 INFO - [mozharness: 2016-10-26 20:31:53.341924Z] Running populate-webroot step. 13:31:53 INFO - Running pre-action listener: _resource_record_pre_action 13:31:53 INFO - Running main action method: populate_webroot 13:31:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:31:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:31:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:31:53 INFO - '--tppagecycles', 13:31:53 INFO - '7'], 13:31:53 INFO - 'tests': ['tsvgm']}}, 13:31:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:31:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:31:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:31:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:31:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['damp', 'tps']}, 13:31:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'tests': ['damp', 'tps']}, 13:31:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['dromaeo_dom']}, 13:31:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:31:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['basic_compositor_video']}, 13:31:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:31:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['a11yr', 13:31:53 INFO - 'ts_paint', 13:31:53 INFO - 'tpaint', 13:31:53 INFO - 'sessionrestore', 13:31:53 INFO - 'sessionrestore_no_auto_restore', 13:31:53 INFO - 'tabpaint']}, 13:31:53 INFO - 'other-e10s': {'tests': ['a11yr', 13:31:53 INFO - 'ts_paint', 13:31:53 INFO - 'tpaint', 13:31:53 INFO - 'sessionrestore', 13:31:53 INFO - 'sessionrestore_no_auto_restore', 13:31:53 INFO - 'tabpaint']}, 13:31:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:31:53 INFO - 'ts_paint', 13:31:53 INFO - 'tpaint', 13:31:53 INFO - 'sessionrestore', 13:31:53 INFO - 'sessionrestore_no_auto_restore', 13:31:53 INFO - 'tabpaint']}, 13:31:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:31:53 INFO - 'ts_paint', 13:31:53 INFO - 'tpaint', 13:31:53 INFO - 'sessionrestore', 13:31:53 INFO - 'sessionrestore_no_auto_restore', 13:31:53 INFO - 'tabpaint']}, 13:31:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['a11yr', 13:31:53 INFO - 'ts_paint', 13:31:53 INFO - 'tpaint', 13:31:53 INFO - 'sessionrestore', 13:31:53 INFO - 'sessionrestore_no_auto_restore', 13:31:53 INFO - 'tabpaint']}, 13:31:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['a11yr', 13:31:53 INFO - 'ts_paint', 13:31:53 INFO - 'tpaint', 13:31:53 INFO - 'sessionrestore', 13:31:53 INFO - 'sessionrestore_no_auto_restore', 13:31:53 INFO - 'tabpaint']}, 13:31:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['tsvgx', 13:31:53 INFO - 'tsvgr_opacity', 13:31:53 INFO - 'tart', 13:31:53 INFO - 'tscrollx', 13:31:53 INFO - 'cart']}, 13:31:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:31:53 INFO - 'tsvgr_opacity', 13:31:53 INFO - 'tart', 13:31:53 INFO - 'tscrollx', 13:31:53 INFO - 'cart']}, 13:31:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'talos_options': ['--disable-e10s'], 13:31:53 INFO - 'tests': ['tp5o']}, 13:31:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'tests': ['tp5o']}, 13:31:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'talos_options': ['--disable-e10s', 13:31:53 INFO - '--xperf_path', 13:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:53 INFO - 'tests': ['tp5n']}, 13:31:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:53 INFO - 'talos_options': ['--xperf_path', 13:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:53 INFO - 'tests': ['tp5n']}}, 13:31:53 INFO - 'talos.zip': {'path': '', 13:31:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:31:53 INFO - Running post-action listener: _resource_record_post_action 13:31:53 INFO - [mozharness: 2016-10-26 20:31:53.364315Z] Finished populate-webroot step (success) 13:31:53 INFO - [mozharness: 2016-10-26 20:31:53.364404Z] Running create-virtualenv step. 13:31:53 INFO - Running pre-action listener: _resource_record_pre_action 13:31:53 INFO - Running main action method: create_virtualenv 13:31:53 INFO - Creating virtualenv /builds/slave/test/build/venv 13:31:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:31:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:31:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:31:53 INFO - Using real prefix '/usr' 13:31:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:31:53 INFO - Installing distribute.............................................................................................................................................................................................done. 13:31:55 INFO - Installing pip.................done. 13:31:55 INFO - Return code: 0 13:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:31:56 INFO - Reading from file tmpfile_stdout 13:31:56 INFO - Output received: 13:31:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:31:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:56 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:31:56 INFO - Using env: {'DISPLAY': ':0', 13:31:56 INFO - 'HOME': '/home/cltbld', 13:31:56 INFO - 'LANG': 'en_US.UTF-8', 13:31:56 INFO - 'LANGUAGE': 'en_US:en', 13:31:56 INFO - 'LOGNAME': 'cltbld', 13:31:56 INFO - 'MAIL': '/var/mail/cltbld', 13:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:56 INFO - 'MOZ_NO_REMOTE': '1', 13:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:56 INFO - 'NO_EM_RESTART': '1', 13:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:56 INFO - 'PWD': '/builds/slave/test', 13:31:56 INFO - 'SHELL': '/bin/bash', 13:31:56 INFO - 'SHLVL': '1', 13:31:56 INFO - 'TERM': 'linux', 13:31:56 INFO - 'TMOUT': '86400', 13:31:56 INFO - 'USER': 'cltbld', 13:31:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:56 INFO - '_': '/tools/buildbot/bin/python'} 13:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:31:56 INFO - Cleaning up... 13:31:56 INFO - Return code: 0 13:31:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:56 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:31:56 INFO - Using env: {'DISPLAY': ':0', 13:31:56 INFO - 'HOME': '/home/cltbld', 13:31:56 INFO - 'LANG': 'en_US.UTF-8', 13:31:56 INFO - 'LANGUAGE': 'en_US:en', 13:31:56 INFO - 'LOGNAME': 'cltbld', 13:31:56 INFO - 'MAIL': '/var/mail/cltbld', 13:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:56 INFO - 'MOZ_NO_REMOTE': '1', 13:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:56 INFO - 'NO_EM_RESTART': '1', 13:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:56 INFO - 'PWD': '/builds/slave/test', 13:31:56 INFO - 'SHELL': '/bin/bash', 13:31:56 INFO - 'SHLVL': '1', 13:31:56 INFO - 'TERM': 'linux', 13:31:56 INFO - 'TMOUT': '86400', 13:31:56 INFO - 'USER': 'cltbld', 13:31:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:56 INFO - '_': '/tools/buildbot/bin/python'} 13:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:56 INFO - Downloading/unpacking psutil>=3.1.1 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:58 INFO - Installing collected packages: psutil 13:31:58 INFO - Running setup.py install for psutil 13:31:58 INFO - building 'psutil._psutil_linux' extension 13:31:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:31:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:31:58 INFO - building 'psutil._psutil_posix' extension 13:31:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:31:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:31:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:59 INFO - Successfully installed psutil 13:31:59 INFO - Cleaning up... 13:31:59 INFO - Return code: 0 13:31:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:59 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:31:59 INFO - Using env: {'DISPLAY': ':0', 13:31:59 INFO - 'HOME': '/home/cltbld', 13:31:59 INFO - 'LANG': 'en_US.UTF-8', 13:31:59 INFO - 'LANGUAGE': 'en_US:en', 13:31:59 INFO - 'LOGNAME': 'cltbld', 13:31:59 INFO - 'MAIL': '/var/mail/cltbld', 13:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:59 INFO - 'MOZ_NO_REMOTE': '1', 13:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:59 INFO - 'NO_EM_RESTART': '1', 13:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:31:59 INFO - 'PWD': '/builds/slave/test', 13:31:59 INFO - 'SHELL': '/bin/bash', 13:31:59 INFO - 'SHLVL': '1', 13:31:59 INFO - 'TERM': 'linux', 13:31:59 INFO - 'TMOUT': '86400', 13:31:59 INFO - 'USER': 'cltbld', 13:31:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:59 INFO - '_': '/tools/buildbot/bin/python'} 13:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:32:01 INFO - Installing collected packages: mozsystemmonitor 13:32:01 INFO - Running setup.py install for mozsystemmonitor 13:32:01 INFO - Successfully installed mozsystemmonitor 13:32:01 INFO - Cleaning up... 13:32:01 INFO - Return code: 0 13:32:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:01 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:32:01 INFO - Using env: {'DISPLAY': ':0', 13:32:01 INFO - 'HOME': '/home/cltbld', 13:32:01 INFO - 'LANG': 'en_US.UTF-8', 13:32:01 INFO - 'LANGUAGE': 'en_US:en', 13:32:01 INFO - 'LOGNAME': 'cltbld', 13:32:01 INFO - 'MAIL': '/var/mail/cltbld', 13:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:01 INFO - 'MOZ_NO_REMOTE': '1', 13:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:01 INFO - 'NO_EM_RESTART': '1', 13:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:01 INFO - 'PWD': '/builds/slave/test', 13:32:01 INFO - 'SHELL': '/bin/bash', 13:32:01 INFO - 'SHLVL': '1', 13:32:01 INFO - 'TERM': 'linux', 13:32:01 INFO - 'TMOUT': '86400', 13:32:01 INFO - 'USER': 'cltbld', 13:32:01 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:01 INFO - '_': '/tools/buildbot/bin/python'} 13:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:01 INFO - Downloading/unpacking jsonschema==2.5.1 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:03 INFO - warning: no files found matching '*.txt' 13:32:03 INFO - no previously-included directories found matching 'build' 13:32:03 INFO - no previously-included directories found matching 'dist' 13:32:03 INFO - no previously-included directories found matching '.git*' 13:32:03 INFO - Installing collected packages: jsonschema, functools32 13:32:03 INFO - Running setup.py install for functools32 13:32:04 INFO - warning: no files found matching '*.txt' 13:32:04 INFO - no previously-included directories found matching 'build' 13:32:04 INFO - no previously-included directories found matching 'dist' 13:32:04 INFO - no previously-included directories found matching '.git*' 13:32:04 INFO - Successfully installed jsonschema functools32 13:32:04 INFO - Cleaning up... 13:32:04 INFO - Return code: 0 13:32:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:04 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:32:04 INFO - Using env: {'DISPLAY': ':0', 13:32:04 INFO - 'HOME': '/home/cltbld', 13:32:04 INFO - 'LANG': 'en_US.UTF-8', 13:32:04 INFO - 'LANGUAGE': 'en_US:en', 13:32:04 INFO - 'LOGNAME': 'cltbld', 13:32:04 INFO - 'MAIL': '/var/mail/cltbld', 13:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:04 INFO - 'MOZ_NO_REMOTE': '1', 13:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:04 INFO - 'NO_EM_RESTART': '1', 13:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:04 INFO - 'PWD': '/builds/slave/test', 13:32:04 INFO - 'SHELL': '/bin/bash', 13:32:04 INFO - 'SHLVL': '1', 13:32:04 INFO - 'TERM': 'linux', 13:32:04 INFO - 'TMOUT': '86400', 13:32:04 INFO - 'USER': 'cltbld', 13:32:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:04 INFO - '_': '/tools/buildbot/bin/python'} 13:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:32:04 INFO - Cleaning up... 13:32:04 INFO - Return code: 0 13:32:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:04 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:32:04 INFO - Using env: {'DISPLAY': ':0', 13:32:04 INFO - 'HOME': '/home/cltbld', 13:32:04 INFO - 'LANG': 'en_US.UTF-8', 13:32:04 INFO - 'LANGUAGE': 'en_US:en', 13:32:04 INFO - 'LOGNAME': 'cltbld', 13:32:04 INFO - 'MAIL': '/var/mail/cltbld', 13:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:04 INFO - 'MOZ_NO_REMOTE': '1', 13:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:04 INFO - 'NO_EM_RESTART': '1', 13:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:04 INFO - 'PWD': '/builds/slave/test', 13:32:04 INFO - 'SHELL': '/bin/bash', 13:32:04 INFO - 'SHLVL': '1', 13:32:04 INFO - 'TERM': 'linux', 13:32:04 INFO - 'TMOUT': '86400', 13:32:04 INFO - 'USER': 'cltbld', 13:32:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:04 INFO - '_': '/tools/buildbot/bin/python'} 13:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:04 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:07 INFO - Downloading docopt-0.6.1.tar.gz 13:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:07 INFO - Running setup.py install for blobuploader 13:32:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:07 INFO - Running setup.py install for requests 13:32:07 INFO - Running setup.py install for docopt 13:32:07 INFO - Successfully installed blobuploader requests docopt 13:32:07 INFO - Cleaning up... 13:32:07 INFO - Return code: 0 13:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:07 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:07 INFO - Using env: {'DISPLAY': ':0', 13:32:07 INFO - 'HOME': '/home/cltbld', 13:32:07 INFO - 'LANG': 'en_US.UTF-8', 13:32:07 INFO - 'LANGUAGE': 'en_US:en', 13:32:07 INFO - 'LOGNAME': 'cltbld', 13:32:07 INFO - 'MAIL': '/var/mail/cltbld', 13:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:07 INFO - 'MOZ_NO_REMOTE': '1', 13:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:07 INFO - 'NO_EM_RESTART': '1', 13:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:07 INFO - 'PWD': '/builds/slave/test', 13:32:07 INFO - 'SHELL': '/bin/bash', 13:32:07 INFO - 'SHLVL': '1', 13:32:07 INFO - 'TERM': 'linux', 13:32:07 INFO - 'TMOUT': '86400', 13:32:07 INFO - 'USER': 'cltbld', 13:32:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:07 INFO - '_': '/tools/buildbot/bin/python'} 13:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:08 INFO - Running setup.py (path:/tmp/pip-AIszT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:08 INFO - Running setup.py (path:/tmp/pip-HFJnTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:08 INFO - Running setup.py (path:/tmp/pip-tAjCwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:08 INFO - Running setup.py (path:/tmp/pip-ZTzB5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:08 INFO - Running setup.py (path:/tmp/pip-Z8BYua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:08 INFO - Running setup.py (path:/tmp/pip-l8D1uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:08 INFO - Running setup.py (path:/tmp/pip-QPzMI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:08 INFO - Running setup.py (path:/tmp/pip-QVGpan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:08 INFO - Running setup.py (path:/tmp/pip-hvQban-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:08 INFO - Running setup.py (path:/tmp/pip-sI8Rf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:08 INFO - Running setup.py (path:/tmp/pip-a5E4Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:08 INFO - Running setup.py (path:/tmp/pip-kv0J8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:08 INFO - Running setup.py (path:/tmp/pip-sZ9cxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:09 INFO - Running setup.py (path:/tmp/pip-QAY58G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:09 INFO - Running setup.py (path:/tmp/pip-klJWE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:09 INFO - Running setup.py (path:/tmp/pip-jHe8SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:09 INFO - Running setup.py (path:/tmp/pip-mMhZ3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:09 INFO - Running setup.py install for manifestparser 13:32:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:09 INFO - Running setup.py install for mozcrash 13:32:09 INFO - Running setup.py install for mozdebug 13:32:09 INFO - Running setup.py install for mozdevice 13:32:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:09 INFO - Running setup.py install for mozfile 13:32:09 INFO - Running setup.py install for mozhttpd 13:32:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:09 INFO - Running setup.py install for mozinfo 13:32:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Running setup.py install for mozInstall 13:32:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Running setup.py install for mozleak 13:32:10 INFO - Running setup.py install for mozlog 13:32:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Running setup.py install for moznetwork 13:32:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Running setup.py install for mozprocess 13:32:10 INFO - Running setup.py install for mozprofile 13:32:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Running setup.py install for mozrunner 13:32:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:10 INFO - Running setup.py install for mozscreenshot 13:32:10 INFO - Running setup.py install for moztest 13:32:11 INFO - Running setup.py install for mozversion 13:32:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:11 INFO - Cleaning up... 13:32:11 INFO - Return code: 0 13:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:11 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:11 INFO - Using env: {'DISPLAY': ':0', 13:32:11 INFO - 'HOME': '/home/cltbld', 13:32:11 INFO - 'LANG': 'en_US.UTF-8', 13:32:11 INFO - 'LANGUAGE': 'en_US:en', 13:32:11 INFO - 'LOGNAME': 'cltbld', 13:32:11 INFO - 'MAIL': '/var/mail/cltbld', 13:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:11 INFO - 'MOZ_NO_REMOTE': '1', 13:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:11 INFO - 'NO_EM_RESTART': '1', 13:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:11 INFO - 'PWD': '/builds/slave/test', 13:32:11 INFO - 'SHELL': '/bin/bash', 13:32:11 INFO - 'SHLVL': '1', 13:32:11 INFO - 'TERM': 'linux', 13:32:11 INFO - 'TMOUT': '86400', 13:32:11 INFO - 'USER': 'cltbld', 13:32:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:11 INFO - '_': '/tools/buildbot/bin/python'} 13:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:11 INFO - Running setup.py (path:/tmp/pip-u9SQxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:11 INFO - Running setup.py (path:/tmp/pip-QTpvDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:11 INFO - Running setup.py (path:/tmp/pip-1Q9Cq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:11 INFO - Running setup.py (path:/tmp/pip-veptTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:11 INFO - Running setup.py (path:/tmp/pip-dNJfzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:11 INFO - Running setup.py (path:/tmp/pip-gIGAo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:11 INFO - Running setup.py (path:/tmp/pip-SSUWd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:11 INFO - Running setup.py (path:/tmp/pip-xF3DoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:11 INFO - Running setup.py (path:/tmp/pip-Xh1R2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:12 INFO - Running setup.py (path:/tmp/pip-SiWSrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:12 INFO - Running setup.py (path:/tmp/pip-LvxJzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:12 INFO - Running setup.py (path:/tmp/pip-JhxrJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:12 INFO - Running setup.py (path:/tmp/pip-VDRZzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:12 INFO - Running setup.py (path:/tmp/pip-J6SPK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:12 INFO - Running setup.py (path:/tmp/pip-gPLpWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:12 INFO - Running setup.py (path:/tmp/pip-Y4q4yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:12 INFO - Running setup.py (path:/tmp/pip-6DCyOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:32:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:14 INFO - Downloading blessings-1.6.tar.gz 13:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:14 INFO - Installing collected packages: blessings 13:32:14 INFO - Running setup.py install for blessings 13:32:14 INFO - Successfully installed blessings 13:32:14 INFO - Cleaning up... 13:32:14 INFO - Return code: 0 13:32:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:15 INFO - Reading from file tmpfile_stdout 13:32:15 INFO - Current package versions: 13:32:15 INFO - argparse == 1.2.1 13:32:15 INFO - blessings == 1.6 13:32:15 INFO - blobuploader == 1.2.4 13:32:15 INFO - docopt == 0.6.1 13:32:15 INFO - functools32 == 3.2.3-2 13:32:15 INFO - jsonschema == 2.5.1 13:32:15 INFO - manifestparser == 1.1 13:32:15 INFO - mozInstall == 1.12 13:32:15 INFO - mozcrash == 0.17 13:32:15 INFO - mozdebug == 0.1 13:32:15 INFO - mozdevice == 0.48 13:32:15 INFO - mozfile == 1.2 13:32:15 INFO - mozhttpd == 0.7 13:32:15 INFO - mozinfo == 0.9 13:32:15 INFO - mozleak == 0.1 13:32:15 INFO - mozlog == 3.4 13:32:15 INFO - moznetwork == 0.27 13:32:15 INFO - mozprocess == 0.23 13:32:15 INFO - mozprofile == 0.28 13:32:15 INFO - mozrunner == 6.12 13:32:15 INFO - mozscreenshot == 0.1 13:32:15 INFO - mozsystemmonitor == 0.3 13:32:15 INFO - moztest == 0.7 13:32:15 INFO - mozversion == 1.4 13:32:15 INFO - psutil == 3.1.1 13:32:15 INFO - requests == 1.2.3 13:32:15 INFO - wsgiref == 0.1.2 13:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:15 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:32:15 INFO - Using env: {'DISPLAY': ':0', 13:32:15 INFO - 'HOME': '/home/cltbld', 13:32:15 INFO - 'LANG': 'en_US.UTF-8', 13:32:15 INFO - 'LANGUAGE': 'en_US:en', 13:32:15 INFO - 'LOGNAME': 'cltbld', 13:32:15 INFO - 'MAIL': '/var/mail/cltbld', 13:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:15 INFO - 'MOZ_NO_REMOTE': '1', 13:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:15 INFO - 'NO_EM_RESTART': '1', 13:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:15 INFO - 'PWD': '/builds/slave/test', 13:32:15 INFO - 'SHELL': '/bin/bash', 13:32:15 INFO - 'SHLVL': '1', 13:32:15 INFO - 'TERM': 'linux', 13:32:15 INFO - 'TMOUT': '86400', 13:32:15 INFO - 'USER': 'cltbld', 13:32:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:15 INFO - '_': '/tools/buildbot/bin/python'} 13:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:32:15 INFO - Cleaning up... 13:32:15 INFO - Return code: 0 13:32:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:15 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 0x7f6b23bd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, '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': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:15 INFO - Using env: {'DISPLAY': ':0', 13:32:15 INFO - 'HOME': '/home/cltbld', 13:32:15 INFO - 'LANG': 'en_US.UTF-8', 13:32:15 INFO - 'LANGUAGE': 'en_US:en', 13:32:15 INFO - 'LOGNAME': 'cltbld', 13:32:15 INFO - 'MAIL': '/var/mail/cltbld', 13:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:15 INFO - 'MOZ_NO_REMOTE': '1', 13:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:15 INFO - 'NO_EM_RESTART': '1', 13:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:15 INFO - 'PWD': '/builds/slave/test', 13:32:15 INFO - 'SHELL': '/bin/bash', 13:32:15 INFO - 'SHLVL': '1', 13:32:15 INFO - 'TERM': 'linux', 13:32:15 INFO - 'TMOUT': '86400', 13:32:15 INFO - 'USER': 'cltbld', 13:32:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:15 INFO - '_': '/tools/buildbot/bin/python'} 13:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:32:15 INFO - Cleaning up... 13:32:15 INFO - Return code: 0 13:32:15 INFO - Running post-action listener: _resource_record_post_action 13:32:15 INFO - Running post-action listener: _start_resource_monitoring 13:32:15 INFO - Starting resource monitoring. 13:32:15 INFO - [mozharness: 2016-10-26 20:32:15.549965Z] Finished create-virtualenv step (success) 13:32:15 INFO - [mozharness: 2016-10-26 20:32:15.550490Z] Running install step. 13:32:15 INFO - Running pre-action listener: _resource_record_pre_action 13:32:15 INFO - Running main action method: install 13:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:15 INFO - Reading from file tmpfile_stdout 13:32:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:15 INFO - Reading from file tmpfile_stdout 13:32:15 INFO - Output received: 13:32:15 INFO - Usage: mozinstall [options] installer 13:32:15 INFO - Options: 13:32:15 INFO - -h, --help show this help message and exit 13:32:15 INFO - -d DEST, --destination=DEST 13:32:15 INFO - Directory to install application into. [default: 13:32:15 INFO - "/builds/slave/test"] 13:32:15 INFO - --app=APP Application being installed. [default: firefox] 13:32:15 INFO - mkdir: /builds/slave/test/build/application 13:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:32:32 INFO - Reading from file tmpfile_stdout 13:32:32 INFO - Output received: 13:32:32 INFO - /builds/slave/test/build/application/firefox/firefox 13:32:32 INFO - Running post-action listener: _resource_record_post_action 13:32:32 INFO - [mozharness: 2016-10-26 20:32:32.765822Z] Finished install step (success) 13:32:32 INFO - [mozharness: 2016-10-26 20:32:32.766068Z] Running run-tests step. 13:32:32 INFO - Running pre-action listener: _resource_record_pre_action 13:32:32 INFO - Running main action method: run_tests 13:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:32 INFO - Python 2.7.3 13:32:32 INFO - Return code: 0 13:32:32 INFO - grabbing minidump binary from tooltool 13:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:32:32 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 0x1274930>, '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 0x1275830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1275cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:32:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:32:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:32:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:32 INFO - Return code: 0 13:32:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:32:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:32:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:32:32 INFO - Using env: {'DISPLAY': ':0', 13:32:32 INFO - 'HOME': '/home/cltbld', 13:32:32 INFO - 'LANG': 'en_US.UTF-8', 13:32:32 INFO - 'LANGUAGE': 'en_US:en', 13:32:32 INFO - 'LOGNAME': 'cltbld', 13:32:32 INFO - 'MAIL': '/var/mail/cltbld', 13:32:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:32 INFO - 'MOZ_NO_REMOTE': '1', 13:32:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:32 INFO - 'NO_EM_RESTART': '1', 13:32:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:32 INFO - 'PWD': '/builds/slave/test', 13:32:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:32 INFO - 'SHELL': '/bin/bash', 13:32:32 INFO - 'SHLVL': '1', 13:32:32 INFO - 'TERM': 'linux', 13:32:32 INFO - 'TMOUT': '86400', 13:32:32 INFO - 'USER': 'cltbld', 13:32:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822', 13:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:32 INFO - '_': '/tools/buildbot/bin/python'} 13:32:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:32:33 INFO - mozversion application_buildid: 20161026103002 13:32:33 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:32:33 INFO - mozversion application_display_name: Nightly 13:32:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:33 INFO - mozversion application_name: Firefox 13:32:33 INFO - mozversion application_remotingname: firefox 13:32:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:32:33 INFO - mozversion application_vendor: Mozilla 13:32:33 INFO - mozversion application_version: 52.0a1 13:32:33 INFO - mozversion platform_buildid: 20161026103002 13:32:33 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:32:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:32:33 INFO - mozversion platform_version: 52.0a1 13:32:33 INFO - using testdate: 1477513953 13:32:33 INFO - actual date: 1477513953 13:32:33 INFO - starting webserver on 'localhost:38710' 13:32:33 INFO - SUITE-START | Running 2 tests 13:32:33 INFO - TEST-START | dromaeo_css 13:32:33 INFO - operating with platform_type : linux_ 13:32:33 INFO - Initialising browser for dromaeo_css test... 13:32:33 INFO - TEST-INFO | started process 8349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PjcAJ/profile http://localhost:38710/getInfo.html) 13:32:36 INFO - PROCESS | 8349 | __metrics Screen width/height:1600/1200 13:32:36 INFO - PROCESS | 8349 | colorDepth:24 13:32:36 INFO - PROCESS | 8349 | Browser inner width/height: 1024/697 13:32:36 INFO - PROCESS | 8349 | __metrics 13:32:37 INFO - PROCESS | 8349 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:32:37 INFO - PROCESS | 8349 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:32:38 INFO - PROCESS | 8349 | console.error: PushService: 13:32:38 INFO - PROCESS | 8349 | stateChangeProcessEnqueue: Error transitioning state 13:32:38 INFO - PROCESS | 8349 | UnknownError 13:32:38 INFO - TEST-INFO | 8349: exit 0 13:32:38 INFO - Browser initialized. 13:32:38 INFO - Running cycle 1/1 for dromaeo_css test... 13:32:38 INFO - TEST-INFO | started process 8435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PjcAJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:50 INFO - PROCESS | 8435 | RSS: Main: 171700224 13:32:50 INFO - PROCESS | 8435 | 13:33:42 INFO - PROCESS | 8435 | 1477514022456 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:35:52 INFO - PROCESS | 8435 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38710/tests/dromaeo/cssquery-ext.html) 13:35:54 INFO - PROCESS | 8435 | RSS: Main: 360480768 13:35:54 INFO - PROCESS | 8435 | 13:38:56 INFO - PROCESS | 8435 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-ext.html (next: http://localhost:38710/tests/dromaeo/cssquery-jquery.html) 13:38:57 INFO - PROCESS | 8435 | RSS: Main: 273588224 13:38:57 INFO - PROCESS | 8435 | 13:41:59 INFO - PROCESS | 8435 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38710/tests/dromaeo/cssquery-mootools.html) 13:42:00 INFO - PROCESS | 8435 | RSS: Main: 254509056 13:42:00 INFO - PROCESS | 8435 | 13:45:02 INFO - PROCESS | 8435 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38710/tests/dromaeo/cssquery-prototype.html) 13:45:02 INFO - PROCESS | 8435 | RSS: Main: 277000192 13:45:02 INFO - PROCESS | 8435 | 13:48:05 INFO - PROCESS | 8435 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38710/tests/dromaeo/cssquery-yui.html) 13:48:06 INFO - PROCESS | 8435 | RSS: Main: 214740992 13:48:06 INFO - PROCESS | 8435 | 13:51:08 INFO - PROCESS | 8435 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-yui.html (next: http://localhost:38710/tests/dromaeo/cssquery-dojo.html) 13:51:09 INFO - PROCESS | 8435 | RSS: Main: 303214592 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | __start_tp_report 13:51:09 INFO - PROCESS | 8435 | _x_x_mozilla_page_load 13:51:09 INFO - PROCESS | 8435 | _x_x_mozilla_page_load_details 13:51:09 INFO - PROCESS | 8435 | |i|pagename|runs| 13:51:09 INFO - PROCESS | 8435 | |0;dojo.html;3045.314804169062;3077.0922577839533;3084.0439463766234;3107.1144723753737;3133.248020475085;5255.185446255827;5337.7598008089635;5366.382865970415;5383.084875571152;5413.7293135343225;5305.549028332587;5318.707471089088;5367.75845086971;5372.9462705372935;5417.6207665463435;4794.161021821167;4875.171220892448;4880.902381952359;4881.511848815107;4894.4371397289415;4864;4883.218685010399;4921.753912304388;4972.751362431882;4983.501649835006;4920.876978075541;4926.5812405945535;4928.876778080558;4971.8011279548955;4989.476105008976;4777.06847164803;4819.228923372279;4823.324734537167;4870.123377791996;4886;4786.760661966888;4830.323754674313;4836.395450568679;4851.878703032417;4908.43552991407;5316.362036555638;5336.279602253685;5340.465953404668;5377.247185394048;5439.265699130607;5543.889122217533;5718.313802343704;5721.113227449752;5722.484976352148;5730.885382292373;5638.351589567212;5680.517156041741;5736.397678243766;5746.396628354005;5818.825435236908;5337.866553336197;5350.8127215547265;5351.518363347317;5404.513593776579;5418.187271909206;5833.533317334603;5840.1239814027385;5843.328017278068;5853.5317174625925;5856.092305692625;5390.218418329398;5493.176023596492;5504.6421982571;5566.443355664482;5582.91625625616;5614.326280846243;5620.887582248332;5634.070378387521;5651.971740141273;5681.4034526374135;5613.691246981455;5617.747201375948;5620.91568626471;5624.85937851557;5630.042892708249;5446.863828404322;5572.024895643246;5596.608237423423;5602.775888964396;5670.744816483269;4240.342746874239;4241.809118589671;4289.485261768607;4293.377460268243;4327.3725309830525;3873.6320049595806;3877.263319969253;3887.611238876146;3924.1170736584613;3928.057266256078;5425.403205647375;5425.755840987165;5426.70153141581;5427.728613569306;5432.972835135878;5615.129654903497;5671.631343962629;5672.829815105553;5711.6001879868845;5736.082226843769;5426.782928682808;5427.701476418756;5430.891382172414;5432.049391356497;5469.644473109315;4817.259186888134;4854.563089321978;4863.319135321058;4866.075445665312;4926;5840.2991641003355;5840.970795145997;5855.180274761452;5889.764409423747;5893.764249429974;5731.140328950691;5760.279965004374;5762.481376676119;5817.243758311392;5821.38875418075;5874.4139082448355;5908.409159084229;5911.261092363455;5912;5920.259967504062;5510.91733623988;5571.916421253765;5605.607607467601;5637.126245431965;5639;5635.774569017193;5667.546596272371;5675.943240567542;5689.203511508475;5770.3364113125845;5539.639923404966;5571.637843540157;5585.385607583082;5594.944050559442;5595.8880822384135;5420.376656684374;5585.69278689676;5590.496855283044;5597.272354593877;5597.328320601554;5461.863453413696;5549.223108764857;5561.555075594024;5568.136938774496;5568.944310557004;5490.3411590609385;5502.339719233558;5519.751611177587;5530.05988981866;5535.308086489189;5439.102548079522;5446.809361672323;5498.092814685532;5499.917501237404;5578.191162281528 13:51:09 INFO - PROCESS | 8435 | |1;ext.html;560.834553806627;600.1447936690216;603.0471854469935;619.8822223777485;633.2907143998721;30796;34028.659713402856;34096.885467179934;34098.488522672116;41214.58785412145;40471.392929106085;44061;44121.77939110308;44225.55774442255;44270.335944960774;8825.779355516115;8978;8980.281577473786;8982.550872456384;8983.326250531203;8135.837283254361;8320.875186872172;8824.955875220616;8913.821723565525;8914.687985920495;8307.210814972597;8362.038365587974;10422.062014418701;10761.62334318299;10768.73078173044;10680.51937662807;10685.038346548808;10742;10748.677539673823;10756.892431075745;10661.573537058508;10694.144468442584;10722.249442539025;10735.677929662123;10775.515101820436;41265;41442.37836432456;41789;41865.58134418678;41869.371959420634;3395.422778127724;3417.4019546579248;3424.708899743525;3543.698785603227;3582.140286331288;30923.536146957813;31581.21046973821;31717.84141079303;33043.33913321744;33448.6655133448;4228.443449048153;4290.099079193373;4323.092150648367;4357.651387888961;4376.606105450493;326882.9999999976;327723;328701;328994;329566;57502.7124864373;57764.42235577675;57839;57845.710771445876;57886.4211357881;35148.12129696727;35678.82160589232;35802.46296305557;37902.43146352807;61182.69408653017;14551.708965820835;14689.853101468849;14703.117812931258;14709.338079786436;14714.484993025193;10050.447225402528;10059.144972677259;10065.547050382751;10066.396016238903;10070.899291006996;19426.396927732872;19474.415767526996;19523.01000911719;19523.511912202026;19525.36833031894;5512.889742205133;6736.360045795642;6875.312468753084;6928.411085057826;7242.3843973262865;889.5374405309203;952.4190243951184;978.3933960944261;1022.2639699416557;1176.9117316201318;32089.51865722016;32252.677473225438;32497.51253731196;32547.674523254937;32619.836900815342;1051.5793682526898;1067;1111.1610733895857;1122.685648018556;1183.928964262147;16921.51374181924;17009.829901700825;17160.82839171617;17185;17316.307347706203;435266;438902;438989;439431;440141;59796;60170;60180.39819601835;60262;60314.39685603088;1222.5109956017486;1238.2508582307755;1245.4395522014947;1316.5260506217753;1330.407968454048;32893.50659740154;34387.82806085954;34392.312153756284;35799.46300805438;36311.45532816957;54079.459205407446;57448.71275643595;59053.570982175646;59168.408315918015;65911;445392;456501;457288;457758;458226;43404;43447.782761087255;43523;44348.556514434444;45715.54284457113;47871.76064119657;48495.5150448491;48539.514604854914;49257.2611410822;49497.50502494929;40578.79710601428;41509.58490415057;41593.37609935914;42127.789361053;43565.34651980159;41457.37813932854;41654.148096761426;41695.374569380874;41765.490772252924;42235.7888210557;32674.50988235226;33327;33813.66186338203;33891.32217355688;34003.319933600695;35126.12184695403;36642.247128382674;37112;37634.24731505409;37973.620263797005;27641.585376219777;28216.15351539457;28299.575506367833;28400.85799570989;28472.857635712517 13:51:09 INFO - PROCESS | 8435 | |2;jquery.html;375.2925734989547;390.4260736717025;397.09660522311736;401.8894803928918;415.6550063447339;13118;15196.392144314228;16121.274542645566;19410.126544305505;19420.902895485502;18481;18790.718139227924;19132.426027219204;19466;19468.41594752156;5591.133374326976;5729.512991395736;5837.854053648672;5845.415458454142;5869.8239052828485;3906.199229158016;4085.1829634073156;5644.238027866227;5770.538356931456;6146.262448506185;6429.549931504796;6487.286398496161;6511.9348806512035;6540.640264785435;6550.410463058324;5441.72119551905;5649.519790817785;5691.51622112121;5810.535157187415;6486.221653401599;5449.427810079924;5621.381648018714;5628.943710562883;5629.80295689653;5633.8309850704545;13603.523876664269;14022.509212177525;14032.649183770487;14036.438542458289;14052.648683782885;2393.6529203265604;2490.501899620065;2563.4104156044214;2653.0846857834017;3004.53429718394;14155;15422;15852.682946341123;16178.676426471404;16324.428644997368;1934.3713293179633;1939.3018513335187;1949.512621844539;1975.2743987003148;2065.824404925583;88680;95702;98023;98245;100220.49889750505;17012.31950721982;17111.401100961408;17200;17297.221625026905;17535.580561790583;31611.36777264442;31726.496068305943;31794.523082153788;31918.202044948597;31941.520877186395;8867.822643547093;8906.777330566787;8928.375013748975;9235.907640923504;9240.122188392092;7327.74352897646;7457.32884040439;7462.626868656654;7541.321281084619;7626.351760100342;8622.879025726616;8672.913270867211;8701.521416322163;8748.168923952215;8903.821923561492;2569.3833479964674;3067.5550897157723;3251.105945864906;3285.852136653856;3430.9485357719655;424.8959005043784;432.3989654380414;442.69896470399794;838.2748922182268;898.3621628643606;11741.823872641917;12153.574624888086;12245.69385765363;12433.254004759743;12447.564335248222;438.3424862705941;454.096348266953;461.9769011549409;469.1227404753133;476.7640018191018;6077.75688972445;6368.617882926947;6431;6458.2895881453005;6479.481641468671;452446;459319;463664;464814;465824;90871;94371.52814235885;94722;94980.52509737546;95379;444.8198479615761;965.280865755017;1013.4527355228389;1014.1633152649094;1014.700663304327;16281.185940703155;16472.588185295463;16714.16429178512;17397.13014349303;17718.91140544289;41566.37650435185;42209;42603.5739642612;43108.78445607877;43397.132057359304;52965.47034529605;53207.46792532025;53490;60107.39892601018;61397.38602614096;8166.836663266583;8175.959120204361;8411.70559030431;8429.199226073513;8557.786055348666;11028.503717332578;12050.578229761917;12560.560380386643;12785.954247320384;13025.804612930624;10619.681409557727;10697.893021069689;11096.833547496633;11263.718407039561;11308.886911131112;10500.369977801356;10942.17933654995;10955.452227388758;11022.50398732043;11114.44427778624;10739.838902416313;11290.830637540279;11300.886991130312;11445.771084578095;11769.882301177222;7267.200607933229;7292.5624462530295;7398.9630051851545;7592.962035189788;8728.869066964127;9908.25688073383;10766.946165269124;10817.945910270399;11216.495257713259;11402.144839137263 13:51:09 INFO - PROCESS | 8435 | |3;mootools.html;1470.5588323502946;1492.8432514585968;1596.2338077722693;1718.7679663245458;1780.5192597998541;7750.186230445806;8030.357571394289;8544.57277136143;9159.542022898853;9160.175584197412;8499.362547808909;8805.823883522326;8807.339449541278;8988.730338089868;8997.325200609965;2284.9200277990276;2301.171578231835;2317.3279748872806;2338.3920180753043;2346.4603141277516;2025.1089520610883;2081.43801173683;2306.2735238399932;2327.325075728037;2374.361690433604;2191.923282685106;2248.786365295294;2272.170657709932;2275.6586512023246;2286.554121946221;2260.095961615367;2269.171752310403;2286.222684287342;2287.2337766848127;2306.5386922615376;2273.7271527416815;2288.599495088353;2300.4363930836885;2310.572544079351;2316.5830150572892;9048.864267036;9224.815503689888;9224.8616270756;9226.40028398152;9228.077192280785;5157.53582177602;5297.470252974672;5304.310439642861;5306.787728490855;5309.203619457074;3375.831208439593;3383.8984830455124;3386.373520898642;3431.6396778338167;3444.8622055117767;1018.3991445047384;1028.984565231522;1029.1818004686218;1041.1358572384902;1042.062144070335;12445.564405245863;12633.747325053448;12635.87364126356;12673.176243544232;12695.809562856564;4373.387725718402;4492.5507449255465;4625.121226966866;4647.697899636512;4651.906961860744;10629.362238265729;10631.627893023708;10647.361158330525;10648.893511064945;10667.253292269466;5185.844424667266;5190.455002224788;5194.220866869924;5196.064708352457;5200.92198617021;4706.1999460091865;4708;4739.478657347689;4788.736619485892;4795.544423279783;3922.1763429679518;3959.8812035638402;4036.7779772112817;4065.796710164539;4106.7946602669745;1157.1263695909702;1191.9463624136936;1301.7721898667885;1303.850057243429;1327.6083555351001;818.5566085235567;846.251067804997;906.8322360363354;941.1388579449864;993.0218734546465;5905.320888097838;6013.51891848651;6042.969785151046;6089.817305480843;6216.906746398808;962.3696478806393;973.4694591447678;979.9167070799062;985.5959056786826;988.6737376665683;3980.5621381647998;4077.673786097105;4087.570805065485;4094.2220978014084;4110.979445102756;10417.374957502574;10882.455877206266;11311.095112390989;11317.660470185907;11332.830007549894;10713.517891694892;11184.217104802585;11199.888001120047;11200.21598488098;11208.103351731841;8170.182981701902;8406.453580517247;8472.237498625153;8553.82892342162;8562.143785621389;6015.338312785678;6115.877682446415;6134.079888016833;6172.074188871705;6329.367063293634;10243.897561024593;10253.9487302566;10356.896431035593;10386.324888882198;10444.63443779464;10642.8403573948;10782.514786834769;10787.460626968777;10802.621908233174;10803.189760768131;7821.55301269267;7822.804429889298;7836.568988705676;7897.802554935943;7917.643706033357;8236.876446853183;8237.670493180445;8331.583420828812;8333.541655209021;8372.790680233044;7441.925580744123;7630.389568834591;7631.122420921665;7634.427417943565;7906.367490600853;7259.548090381839;7367.447441441806;7414.555126692416;7428.517146385468;7608.2391760823475;6672.399484046459;6778.3221677831825;6788.694508747217;6790.287019862843;6792.490563207878;4720.055988802184;4865.659403841839;4936.629752768628;4974.278729584263;5033.99320135967;4705.106029854317;4749.548792864673;4808.567228949411;4860.902781944412;4933.087378834927 13:51:09 INFO - PROCESS | 8435 | |4;prototype.html;301.2198406128128;314.4042040333568;318.0347644897735;318.1632307032504;322.1929067685449;4900.460949295583;5205.16717325228;5386.757595908184;5389.649672771267;5402.810901618439;5258.842234732954;5357.49103835136;5375.704336261504;5376.650517716355;5386.226093561819;4219.493660760713;4224.260754367973;4224.5353011168745;4228.788560571967;4228.957710422903;3944.447777311179;4215;4228.112096459748;4238.4913810342805;4238.618524332825;3877.864274750384;4113.177364527107;4128.855490057848;4137.151883863816;4144.347617524787;4108.952217184614;4116;4118.402831589433;4119.114390406062;4121.237571049365;3637.6907962823193;3645.38028535147;3646.835892384849;3651.032476393758;3656.8171591420323;5019.824306149304;5194.68831870089;5237.292965449692;5242.528172464458;5258.6318957672975;4719.669623126382;4725.3384526166365;4729.905401891977;4733.715977041388;4742.976285118552;5631.662100273997;5641.746121424505;5641.774329026875;5648.265725455705;5666.121751128581;3787.772733635963;3915.7846318452475;3947.210557888405;3967.4842270504937;3971.721979461439;5546.4453554644615;5683.516901063374;5830.970845145789;5849.444302791228;5865.856158049182;3887.339152344052;3899.941500877489;3909.354956432214;3909.9413508797393;3953.723239373274;4068.9248483273745;4094.447249621263;4099.323611604112;4099.508059032935;4108.568600296986;4618.538146185355;4711.128441238382;4712.4317247099725;4713.198756211452;4744.312074749211;5597.692126933058;5618.280644258761;5636.408177141423;5638.633488823213;5667.263255776723;1390.1728471559406;1402.1727180963076;1403.733290674789;1409.8801601863956;1410.9435622574981;839.7858546070835;884.6903583745766;895.2185151548372;902.7652810269246;903.8599017152352;4724.95275047252;4769.284607308931;4790.5448982346625;4803.78382972767;4811.374521312207;5059.62052846038;5091.490850914953;5094.032133894548;5103.668261562986;5112.821051263188;4583.479086502411;4761.9759360286425;4767.451743049524;4799.256115302133;4815.735134567562;2718.4019515706514;2721.67339919207;2736.616873637692;2753.366725653111;2757.834529928211;5139.357580302462;5147.279380886679;5155.432902380735;5164.244156986642;5178.741062946838;4866.343043689128;4977.565830806291;5048.116579598555;5073.959838233153;5086.872828179326;5117.7758012453405;5138.2292656101135;5158.303629010111;5165.760217547837;5251;5011.874703132451;5020.47285035066;5032.62255330859;5033.823816166417;5043.344365232496;4987.376577927759;4991.750412479434;5234.345706786652;5676.460736230051;5758.675504633874;5668.489835914787;5789.884202316014;5815.45890339052;5953.28560572734;5960.3443621202505;4111.9177616446905;4115.1975364803575;4137.54487006423;4147.65657403566;4156.8129434174925;5766.857062900813;5870.7945221917025;5872;5874.736931559735;5890.352061273171;5548.750306236309;5602.4957753802355;5604.663720176803;5641.661500309994;5645.209670646195;5590.385057643574;5612.214289999321;5624.550035997192;5660.54715622741;5687.857803554944;5411.485908838654;5642.407547207484;5652.971735141463;5673.659580425187;5696.724383479599;5610.803621873215;5651.491365777099;5675.375708671961;5677.914831277451;5707.6290041147195;5528.723563821713;5552.666839989613;5554.305711786027;5558.166275058774;5581.386047534849 13:51:09 INFO - PROCESS | 8435 | |5;yui.html;702.1784512120818;712.1596516110988;745.4264670943218;779.2800841821032;800.5236884053987;12836.935815320921;12869.5495657652;12933.611991640266;12992.675183120427;13020;12162.087843411735;12320.075994300441;12345.444454999524;12576.874231257685;13267.004974626894;791.3431851563203;803.1286054630733;803.1927912447982;803.895493585833;804.5132694719698;656.2846497317922;674.1101745695684;778.2412148155531;802.9598520074002;805.8670319397293;847.4237518487427;856.7044369692477;858.0947100808644;858.5149390594325;859.0893652728097;840.7141571865565;848.6690190825583;849.0702680564772;849.2399302624148;850.1158794853345;502.1964856230039;518.582541054451;595.6396380190009;619.7520991603395;621.0094898636668;13204.207747535178;13813.930930345285;13876.375563099584;13877;13902.582922512342;12253.877461225451;12607.369631518479;12645.17806342594;12840.935795320964;12919.870801292054;11018;11058.723531911686;11154.386508742016;11241.494132763963;11422.94288528552;4228.386883901848;4250.171216612762;4279.764612946286;4333.934990975138;4497.685162038659;64752.352476475106;65584;66692;66892.3310766891;67333;10554.208434367452;10635.840462393071;10822.026017658449;10844.295120817122;11101.44492775358;19204.63918814202;19225.32711355096;19239.13423895928;19254.422367329003;20750.169993200103;7706.691732330644;7746.30283274508;7873.724419645285;7889.447738658238;7915.76252712408;4327.437433133672;4377.890552736207;4379.97070688388;4401.691881568324;4531.728096314232;3301.4552598821406;3404.8638054478038;3406.2506248625264;3408.9488657670154;3409.488576713513;601.8615718384796;616.9259688837368;623.2365352443221;628.632250133677;653.2944420026361;696.5716084608031;696.6795274173835;698.4447364345256;737.1265050914683;739.8002539314463;8748.650053997897;9340.299477539213;9491.335606507617;9614.423134611945;9771.609135634637;663.2770280394393;680.2143524229523;702.8664553734876;703.549728173969;704.8378872859271;4032.334286780251;4244.745315281093;4272.722273052242;4304.817366851802;4467;85664;89845.55077224702;90056;90844.54577727201;93927;64431;64806.351936480976;78041.90350495682;79099;80821.19178808137;41413.58586414097;50498;53761.46238537643;57986.999999999156;63755.36244637587;9122.270218382646;9398.342116052085;9412.48231347255;9558.95220523893;9648.421094734338;40393.39409908795;41791.16417671569;43445.348319774595;43586.782066089465;44298.335524966504;40346.59653403428;40646.39030414487;45369.54630453785;57453;60706;11666.591669291534;11800.527978881091;11822.625628517504;12062;12931.612051638465;13342.381478380934;13509.72980540364;13932.30338483092;13981.510647127301;14063.859361406256;12702.428390722254;12849.51570047713;13029.869701302865;13050.802553374484;13560.660983475493;12026.218295810744;12480.913759939516;12616.405217348078;12875.484980601046;13764.036517443683;12120.393980301125;12327.445264963277;12483.581463409777;12985.935070324587;13288.667783305495;10182.389056656624;10296.433696146783;10444.58998035286;10569.577216911237;10686.198535110054;10616.734581635212;11199.66401007971;11308.49111789988;11385.715357116138;11635.650930472098 13:51:09 INFO - PROCESS | 8435 | __end_tp_report 13:51:09 INFO - PROCESS | 8435 | __start_cc_report 13:51:09 INFO - PROCESS | 8435 | _x_x_mozilla_cycle_collect,1804 13:51:09 INFO - PROCESS | 8435 | __end_cc_report 13:51:09 INFO - PROCESS | 8435 | __startTimestamp1477515069214__endTimestamp 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | ------- Summary: start ------- 13:51:09 INFO - PROCESS | 8435 | Number of tests: 6 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | [#0] dojo.html Cycles:165 Average:5292.55 Median:5493.18 stddev:595.09 (10.8%) stddev-sans-first:570.20 13:51:09 INFO - PROCESS | 8435 | Values: 3045.3 3077.1 3084.0 3107.1 3133.2 5255.2 5337.8 5366.4 5383.1 5413.7 5305.5 5318.7 5367.8 5372.9 5417.6 4794.2 4875.2 4880.9 4881.5 4894.4 4864.0 4883.2 4921.8 4972.8 4983.5 4920.9 4926.6 4928.9 4971.8 4989.5 4777.1 4819.2 4823.3 4870.1 4886.0 4786.8 4830.3 4836.4 4851.9 4908.4 5316.4 5336.3 5340.5 5377.2 5439.3 5543.9 5718.3 5721.1 5722.5 5730.9 5638.4 5680.5 5736.4 5746.4 5818.8 5337.9 5350.8 5351.5 5404.5 5418.2 5833.5 5840.1 5843.3 5853.5 5856.1 5390.2 5493.2 5504.6 5566.4 5582.9 5614.3 5620.9 5634.1 5652.0 5681.4 5613.7 5617.7 5620.9 5624.9 5630.0 5446.9 5572.0 5596.6 5602.8 5670.7 4240.3 4241.8 4289.5 4293.4 4327.4 3873.6 3877.3 3887.6 3924.1 3928.1 5425.4 5425.8 5426.7 5427.7 5433.0 5615.1 5671.6 5672.8 5711.6 5736.1 5426.8 5427.7 5430.9 5432.0 5469.6 4817.3 4854.6 4863.3 4866.1 4926.0 5840.3 5841.0 5855.2 5889.8 5893.8 5731.1 5760.3 5762.5 5817.2 5821.4 5874.4 5908.4 5911.3 5912.0 5920.3 5510.9 5571.9 5605.6 5637.1 5639.0 5635.8 5667.5 5675.9 5689.2 5770.3 5539.6 5571.6 5585.4 5594.9 5595.9 5420.4 5585.7 5590.5 5597.3 5597.3 5461.9 5549.2 5561.6 5568.1 5568.9 5490.3 5502.3 5519.8 5530.1 5535.3 5439.1 5446.8 5498.1 5499.9 5578.2 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | [#1] ext.html Cycles:180 Average:57305.14 Median:37768.34 stddev:108579.95 (287.5%) stddev-sans-first:108800.96 13:51:09 INFO - PROCESS | 8435 | Values: 560.8 600.1 603.0 619.9 633.3 30796.0 34028.7 34096.9 34098.5 41214.6 40471.4 44061.0 44121.8 44225.6 44270.3 8825.8 8978.0 8980.3 8982.6 8983.3 8135.8 8320.9 8825.0 8913.8 8914.7 8307.2 8362.0 10422.1 10761.6 10768.7 10680.5 10685.0 10742.0 10748.7 10756.9 10661.6 10694.1 10722.2 10735.7 10775.5 41265.0 41442.4 41789.0 41865.6 41869.4 3395.4 3417.4 3424.7 3543.7 3582.1 30923.5 31581.2 31717.8 33043.3 33448.7 4228.4 4290.1 4323.1 4357.7 4376.6 326883.0 327723.0 328701.0 328994.0 329566.0 57502.7 57764.4 57839.0 57845.7 57886.4 35148.1 35678.8 35802.5 37902.4 61182.7 14551.7 14689.9 14703.1 14709.3 14714.5 10050.4 10059.1 10065.5 10066.4 10070.9 19426.4 19474.4 19523.0 19523.5 19525.4 5512.9 6736.4 6875.3 6928.4 7242.4 889.5 952.4 978.4 1022.3 1176.9 32089.5 32252.7 32497.5 32547.7 32619.8 1051.6 1067.0 1111.2 1122.7 1183.9 16921.5 17009.8 17160.8 17185.0 17316.3 435266.0 438902.0 438989.0 439431.0 440141.0 59796.0 60170.0 60180.4 60262.0 60314.4 1222.5 1238.3 1245.4 1316.5 1330.4 32893.5 34387.8 34392.3 35799.5 36311.5 54079.5 57448.7 59053.6 59168.4 65911.0 445392.0 456501.0 457288.0 457758.0 458226.0 43404.0 43447.8 43523.0 44348.6 45715.5 47871.8 48495.5 48539.5 49257.3 49497.5 40578.8 41509.6 41593.4 42127.8 43565.3 41457.4 41654.1 41695.4 41765.5 42235.8 32674.5 33327.0 33813.7 33891.3 34003.3 35126.1 36642.2 37112.0 37634.2 37973.6 27641.6 28216.2 28299.6 28400.9 28472.9 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | [#2] jquery.html Cycles:180 Average:28791.11 Median:41887.69 stddev:76597.55 (182.9%) stddev-sans-first:76782.71 13:51:09 INFO - PROCESS | 8435 | Values: 375.3 390.4 397.1 401.9 415.7 13118.0 15196.4 16121.3 19410.1 19420.9 18481.0 18790.7 19132.4 19466.0 19468.4 5591.1 5729.5 5837.9 5845.4 5869.8 3906.2 4085.2 5644.2 5770.5 6146.3 6429.5 6487.3 6511.9 6540.6 6550.4 5441.7 5649.5 5691.5 5810.5 6486.2 5449.4 5621.4 5628.9 5629.8 5633.8 13603.5 14022.5 14032.6 14036.4 14052.6 2393.7 2490.5 2563.4 2653.1 3004.5 14155.0 15422.0 15852.7 16178.7 16324.4 1934.4 1939.3 1949.5 1975.3 2065.8 88680.0 95702.0 98023.0 98245.0 100220.5 17012.3 17111.4 17200.0 17297.2 17535.6 31611.4 31726.5 31794.5 31918.2 31941.5 8867.8 8906.8 8928.4 9235.9 9240.1 7327.7 7457.3 7462.6 7541.3 7626.4 8622.9 8672.9 8701.5 8748.2 8903.8 2569.4 3067.6 3251.1 3285.9 3430.9 424.9 432.4 442.7 838.3 898.4 11741.8 12153.6 12245.7 12433.3 12447.6 438.3 454.1 462.0 469.1 476.8 6077.8 6368.6 6431.0 6458.3 6479.5 452446.0 459319.0 463664.0 464814.0 465824.0 90871.0 94371.5 94722.0 94980.5 95379.0 444.8 965.3 1013.5 1014.2 1014.7 16281.2 16472.6 16714.2 17397.1 17718.9 41566.4 42209.0 42603.6 43108.8 43397.1 52965.5 53207.5 53490.0 60107.4 61397.4 8166.8 8176.0 8411.7 8429.2 8557.8 11028.5 12050.6 12560.6 12786.0 13025.8 10619.7 10697.9 11096.8 11263.7 11308.9 10500.4 10942.2 10955.5 11022.5 11114.4 10739.8 11290.8 11300.9 11445.8 11769.9 7267.2 7292.6 7399.0 7593.0 8728.9 9908.3 10766.9 10817.9 11216.5 11402.1 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | [#3] mootools.html Cycles:180 Average:5828.49 Median:4705.65 stddev:3390.22 (72.0%) stddev-sans-first:3383.92 13:51:09 INFO - PROCESS | 8435 | Values: 1470.6 1492.8 1596.2 1718.8 1780.5 7750.2 8030.4 8544.6 9159.5 9160.2 8499.4 8805.8 8807.3 8988.7 8997.3 2284.9 2301.2 2317.3 2338.4 2346.5 2025.1 2081.4 2306.3 2327.3 2374.4 2191.9 2248.8 2272.2 2275.7 2286.6 2260.1 2269.2 2286.2 2287.2 2306.5 2273.7 2288.6 2300.4 2310.6 2316.6 9048.9 9224.8 9224.9 9226.4 9228.1 5157.5 5297.5 5304.3 5306.8 5309.2 3375.8 3383.9 3386.4 3431.6 3444.9 1018.4 1029.0 1029.2 1041.1 1042.1 12445.6 12633.7 12635.9 12673.2 12695.8 4373.4 4492.6 4625.1 4647.7 4651.9 10629.4 10631.6 10647.4 10648.9 10667.3 5185.8 5190.5 5194.2 5196.1 5200.9 4706.2 4708.0 4739.5 4788.7 4795.5 3922.2 3959.9 4036.8 4065.8 4106.8 1157.1 1191.9 1301.8 1303.9 1327.6 818.6 846.3 906.8 941.1 993.0 5905.3 6013.5 6043.0 6089.8 6216.9 962.4 973.5 979.9 985.6 988.7 3980.6 4077.7 4087.6 4094.2 4111.0 10417.4 10882.5 11311.1 11317.7 11332.8 10713.5 11184.2 11199.9 11200.2 11208.1 8170.2 8406.5 8472.2 8553.8 8562.1 6015.3 6115.9 6134.1 6172.1 6329.4 10243.9 10253.9 10356.9 10386.3 10444.6 10642.8 10782.5 10787.5 10802.6 10803.2 7821.6 7822.8 7836.6 7897.8 7917.6 8236.9 8237.7 8331.6 8333.5 8372.8 7441.9 7630.4 7631.1 7634.4 7906.4 7259.5 7367.4 7414.6 7428.5 7608.2 6672.4 6778.3 6788.7 6790.3 6792.5 4720.1 4865.7 4936.6 4974.3 5034.0 4705.1 4749.5 4808.6 4860.9 4933.1 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | [#4] prototype.html Cycles:180 Average:4555.12 Median:5045.73 stddev:1338.29 (26.5%) stddev-sans-first:1303.40 13:51:09 INFO - PROCESS | 8435 | Values: 301.2 314.4 318.0 318.2 322.2 4900.5 5205.2 5386.8 5389.6 5402.8 5258.8 5357.5 5375.7 5376.7 5386.2 4219.5 4224.3 4224.5 4228.8 4229.0 3944.4 4215.0 4228.1 4238.5 4238.6 3877.9 4113.2 4128.9 4137.2 4144.3 4109.0 4116.0 4118.4 4119.1 4121.2 3637.7 3645.4 3646.8 3651.0 3656.8 5019.8 5194.7 5237.3 5242.5 5258.6 4719.7 4725.3 4729.9 4733.7 4743.0 5631.7 5641.7 5641.8 5648.3 5666.1 3787.8 3915.8 3947.2 3967.5 3971.7 5546.4 5683.5 5831.0 5849.4 5865.9 3887.3 3899.9 3909.4 3909.9 3953.7 4068.9 4094.4 4099.3 4099.5 4108.6 4618.5 4711.1 4712.4 4713.2 4744.3 5597.7 5618.3 5636.4 5638.6 5667.3 1390.2 1402.2 1403.7 1409.9 1410.9 839.8 884.7 895.2 902.8 903.9 4725.0 4769.3 4790.5 4803.8 4811.4 5059.6 5091.5 5094.0 5103.7 5112.8 4583.5 4762.0 4767.5 4799.3 4815.7 2718.4 2721.7 2736.6 2753.4 2757.8 5139.4 5147.3 5155.4 5164.2 5178.7 4866.3 4977.6 5048.1 5074.0 5086.9 5117.8 5138.2 5158.3 5165.8 5251.0 5011.9 5020.5 5032.6 5033.8 5043.3 4987.4 4991.8 5234.3 5676.5 5758.7 5668.5 5789.9 5815.5 5953.3 5960.3 4111.9 4115.2 4137.5 4147.7 4156.8 5766.9 5870.8 5872.0 5874.7 5890.4 5548.8 5602.5 5604.7 5641.7 5645.2 5590.4 5612.2 5624.6 5660.5 5687.9 5411.5 5642.4 5653.0 5673.7 5696.7 5610.8 5651.5 5675.4 5677.9 5707.6 5528.7 5552.7 5554.3 5558.2 5581.4 13:51:09 INFO - PROCESS | 8435 | 13:51:09 INFO - PROCESS | 8435 | [#5] yui.html Cycles:180 Average:16770.67 Median:23982.34 stddev:22240.68 (92.7%) stddev-sans-first:22270.34 13:51:09 INFO - PROCESS | 8435 | Values: 702.2 712.2 745.4 779.3 800.5 12836.9 12869.5 12933.6 12992.7 13020.0 12162.1 12320.1 12345.4 12576.9 13267.0 791.3 803.1 803.2 803.9 804.5 656.3 674.1 778.2 803.0 805.9 847.4 856.7 858.1 858.5 859.1 840.7 848.7 849.1 849.2 850.1 502.2 518.6 595.6 619.8 621.0 13204.2 13813.9 13876.4 13877.0 13902.6 12253.9 12607.4 12645.2 12840.9 12919.9 11018.0 11058.7 11154.4 11241.5 11422.9 4228.4 4250.2 4279.8 4333.9 4497.7 64752.4 65584.0 66692.0 66892.3 67333.0 10554.2 10635.8 10822.0 10844.3 11101.4 19204.6 19225.3 19239.1 19254.4 20750.2 7706.7 7746.3 7873.7 7889.4 7915.8 4327.4 4377.9 4380.0 4401.7 4531.7 3301.5 3404.9 3406.3 3408.9 3409.5 601.9 616.9 623.2 628.6 653.3 696.6 696.7 698.4 737.1 739.8 8748.7 9340.3 9491.3 9614.4 9771.6 663.3 680.2 702.9 703.5 704.8 4032.3 4244.7 4272.7 4304.8 4467.0 85664.0 89845.6 90056.0 90844.5 93927.0 64431.0 64806.4 78041.9 79099.0 80821.2 41413.6 50498.0 53761.5 57987.0 63755.4 9122.3 9398.3 9412.5 9559.0 9648.4 40393.4 41791.2 43445.3 43586.8 44298.3 40346.6 40646.4 45369.5 57453.0 60706.0 11666.6 11800.5 11822.6 12062.0 12931.6 13342.4 13509.7 13932.3 13981.5 14063.9 12702.4 12849.5 13029.9 13050.8 13560.7 12026.2 12480.9 12616.4 12875.5 13764.0 12120.4 12327.4 12483.6 12985.9 13288.7 10182.4 10296.4 10444.6 10569.6 10686.2 10616.7 11199.7 11308.5 11385.7 11635.7 13:51:09 INFO - PROCESS | 8435 | -------- Summary: end -------- 13:51:09 INFO - PROCESS | 8435 | 13:51:10 INFO - TEST-INFO | 8435: exit 0 13:51:10 INFO - TEST-OK | dromaeo_css | took 1117074ms 13:51:10 INFO - TEST-START | kraken 13:51:10 INFO - operating with platform_type : linux_ 13:51:10 INFO - Initialising browser for kraken test... 13:51:10 INFO - TEST-INFO | started process 8743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbaW7aP/profile http://localhost:38710/getInfo.html) 13:51:13 INFO - PROCESS | 8743 | __metrics Screen width/height:1600/1200 13:51:13 INFO - PROCESS | 8743 | colorDepth:24 13:51:13 INFO - PROCESS | 8743 | Browser inner width/height: 1024/697 13:51:13 INFO - PROCESS | 8743 | __metrics 13:51:14 INFO - PROCESS | 8743 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:51:14 INFO - PROCESS | 8743 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:51:15 INFO - PROCESS | 8743 | console.error: PushService: 13:51:15 INFO - PROCESS | 8743 | stateChangeProcessEnqueue: Error transitioning state 13:51:15 INFO - PROCESS | 8743 | UnknownError 13:51:15 INFO - TEST-INFO | 8743: exit 0 13:51:15 INFO - Browser initialized. 13:51:15 INFO - Running cycle 1/1 for kraken test... 13:51:15 INFO - TEST-INFO | started process 8824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbaW7aP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:27 INFO - PROCESS | 8824 | RSS: Main: 171827200 13:51:27 INFO - PROCESS | 8824 | 13:51:30 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:31 INFO - PROCESS | 8824 | RSS: Main: 228958208 13:51:31 INFO - PROCESS | 8824 | 13:51:33 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-dft) 13:51:34 INFO - PROCESS | 8824 | RSS: Main: 215568384 13:51:34 INFO - PROCESS | 8824 | 13:51:37 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-fft) 13:51:38 INFO - PROCESS | 8824 | RSS: Main: 298168320 13:51:38 INFO - PROCESS | 8824 | 13:51:40 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-oscillator) 13:51:40 INFO - PROCESS | 8824 | RSS: Main: 208805888 13:51:40 INFO - PROCESS | 8824 | 13:51:43 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:51:43 INFO - PROCESS | 8824 | RSS: Main: 211750912 13:51:43 INFO - PROCESS | 8824 | 13:51:46 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-darkroom) 13:51:47 INFO - PROCESS | 8824 | RSS: Main: 247152640 13:51:47 INFO - PROCESS | 8824 | 13:51:50 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-desaturate) 13:51:51 INFO - PROCESS | 8824 | RSS: Main: 246456320 13:51:51 INFO - PROCESS | 8824 | 13:51:53 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38710/tests/kraken/driver.html?testName=json-parse-financial) 13:51:54 INFO - PROCESS | 8824 | RSS: Main: 246321152 13:51:54 INFO - PROCESS | 8824 | 13:51:55 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:51:56 INFO - PROCESS | 8824 | RSS: Main: 209166336 13:51:56 INFO - PROCESS | 8824 | 13:51:58 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:51:58 INFO - PROCESS | 8824 | RSS: Main: 215597056 13:51:58 INFO - PROCESS | 8824 | 13:52:00 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:01 INFO - PROCESS | 8824 | RSS: Main: 225419264 13:52:01 INFO - PROCESS | 8824 | 13:52:03 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:04 INFO - PROCESS | 8824 | RSS: Main: 233828352 13:52:04 INFO - PROCESS | 8824 | 13:52:07 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:08 INFO - PROCESS | 8824 | RSS: Main: 231555072 13:52:08 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38710/tests/kraken/driver.html?testName=ai-astar) 13:52:09 INFO - PROCESS | 8824 | RSS: Main: 281239552 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | __start_tp_report 13:52:09 INFO - PROCESS | 8824 | _x_x_mozilla_page_load 13:52:09 INFO - PROCESS | 8824 | _x_x_mozilla_page_load_details 13:52:09 INFO - PROCESS | 8824 | |i|pagename|runs| 13:52:09 INFO - PROCESS | 8824 | |0;ai-astar;103;111;110;110;111;110;111;111;111;111 13:52:09 INFO - PROCESS | 8824 | |1;audio-beat-detection;147;122;121;162;125;128;126;133;161;127 13:52:09 INFO - PROCESS | 8824 | |2;audio-dft;161;162;161;162;163;163;162;164;164;162 13:52:09 INFO - PROCESS | 8824 | |3;audio-fft;76;74;74;114;76;76;77;76;101;77 13:52:09 INFO - PROCESS | 8824 | |4;audio-oscillator;82;82;113;82;82;81;103;82;82;106 13:52:09 INFO - PROCESS | 8824 | |5;imaging-gaussian-blur;118;116;117;117;117;117;118;116;116;117 13:52:09 INFO - PROCESS | 8824 | |6;imaging-darkroom;145;145;147;146;145;146;146;145;145;145 13:52:09 INFO - PROCESS | 8824 | |7;imaging-desaturate;86;84;84;84;84;84;83;84;85;84 13:52:09 INFO - PROCESS | 8824 | |8;json-parse-financial;52;53;52;52;52;54;54;52;55;52 13:52:09 INFO - PROCESS | 8824 | |9;json-stringify-tinderbox;60;61;61;60;62;62;61;62;62;61 13:52:09 INFO - PROCESS | 8824 | |10;stanford-crypto-aes;79;79;79;78;80;82;79;79;78;87 13:52:09 INFO - PROCESS | 8824 | |11;stanford-crypto-ccm;134;136;132;130;134;136;135;129;165;131 13:52:09 INFO - PROCESS | 8824 | |12;stanford-crypto-pbkdf2;166;165;165;163;165;165;164;162;165;166 13:52:09 INFO - PROCESS | 8824 | |13;stanford-crypto-sha256-iterative;65;65;66;65;64;64;66;66;63;64 13:52:09 INFO - PROCESS | 8824 | __end_tp_report 13:52:09 INFO - PROCESS | 8824 | __start_cc_report 13:52:09 INFO - PROCESS | 8824 | _x_x_mozilla_cycle_collect,1689 13:52:09 INFO - PROCESS | 8824 | __end_cc_report 13:52:09 INFO - PROCESS | 8824 | __startTimestamp1477515129936__endTimestamp 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | ------- Summary: start ------- 13:52:09 INFO - PROCESS | 8824 | Number of tests: 14 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.47 (2.2%) stddev-sans-first:0.50 13:52:09 INFO - PROCESS | 8824 | Values: 103.0 111.0 110.0 110.0 111.0 110.0 111.0 111.0 111.0 111.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:130.50 stddev:15.68 (12.0%) stddev-sans-first:16.03 13:52:09 INFO - PROCESS | 8824 | Values: 147.0 122.0 121.0 162.0 125.0 128.0 126.0 133.0 161.0 127.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 13:52:09 INFO - PROCESS | 8824 | Values: 161.0 162.0 161.0 162.0 163.0 163.0 162.0 164.0 164.0 162.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.77 (18.1%) stddev-sans-first:14.43 13:52:09 INFO - PROCESS | 8824 | Values: 76.0 74.0 74.0 114.0 76.0 76.0 77.0 76.0 101.0 77.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:12.55 (15.3%) stddev-sans-first:13.01 13:52:09 INFO - PROCESS | 8824 | Values: 82.0 82.0 113.0 82.0 82.0 81.0 103.0 82.0 82.0 106.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 13:52:09 INFO - PROCESS | 8824 | Values: 118.0 116.0 117.0 117.0 117.0 117.0 118.0 116.0 116.0 117.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 13:52:09 INFO - PROCESS | 8824 | Values: 145.0 145.0 147.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.50 13:52:09 INFO - PROCESS | 8824 | Values: 86.0 84.0 84.0 84.0 84.0 84.0 83.0 84.0 85.0 84.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.50 stddev:1.14 (2.2%) stddev-sans-first:1.17 13:52:09 INFO - PROCESS | 8824 | Values: 52.0 53.0 52.0 52.0 52.0 54.0 54.0 52.0 55.0 52.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 13:52:09 INFO - PROCESS | 8824 | Values: 60.0 61.0 61.0 60.0 62.0 62.0 61.0 62.0 62.0 61.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:2.71 (3.4%) stddev-sans-first:2.85 13:52:09 INFO - PROCESS | 8824 | Values: 79.0 79.0 79.0 78.0 80.0 82.0 79.0 79.0 78.0 87.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:134.50 stddev:10.41 (7.7%) stddev-sans-first:11.01 13:52:09 INFO - PROCESS | 8824 | Values: 134.0 136.0 132.0 130.0 134.0 136.0 135.0 129.0 165.0 131.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 13:52:09 INFO - PROCESS | 8824 | Values: 166.0 165.0 165.0 163.0 165.0 165.0 164.0 162.0 165.0 166.0 13:52:09 INFO - PROCESS | 8824 | 13:52:09 INFO - PROCESS | 8824 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 13:52:09 INFO - PROCESS | 8824 | Values: 65.0 65.0 66.0 65.0 64.0 64.0 66.0 66.0 63.0 64.0 13:52:09 INFO - PROCESS | 8824 | -------- Summary: end -------- 13:52:09 INFO - PROCESS | 8824 | 13:52:11 INFO - TEST-INFO | 8824: exit 0 13:52:11 INFO - TEST-OK | kraken | took 61075ms 13:52:11 INFO - SUITE-END | took 1178s 13:52:11 INFO - Completed test suite (00:19:38) 13:52:11 INFO - javascript benchmark 13:52:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.314804169062, 3077.0922577839533, 3084.0439463766234, 3107.1144723753737, 3133.248020475085, 5255.185446255827, 5337.7598008089635, 5366.382865970415, 5383.084875571152, 5413.7293135343225, 5305.549028332587, 5318.707471089088, 5367.75845086971, 5372.9462705372935, 5417.6207665463435, 4794.161021821167, 4875.171220892448, 4880.902381952359, 4881.511848815107, 4894.4371397289415, 4864.0, 4883.218685010399, 4921.753912304388, 4972.751362431882, 4983.501649835006, 4920.876978075541, 4926.5812405945535, 4928.876778080558, 4971.8011279548955, 4989.476105008976, 4777.06847164803, 4819.228923372279, 4823.324734537167, 4870.123377791996, 4886.0, 4786.760661966888, 4830.323754674313, 4836.395450568679, 4851.878703032417, 4908.43552991407, 5316.362036555638, 5336.279602253685, 5340.465953404668, 5377.247185394048, 5439.265699130607, 5543.889122217533, 5718.313802343704, 5721.113227449752, 5722.484976352148, 5730.885382292373, 5638.351589567212, 5680.517156041741, 5736.397678243766, 5746.396628354005, 5818.825435236908, 5337.866553336197, 5350.8127215547265, 5351.518363347317, 5404.513593776579, 5418.187271909206, 5833.533317334603, 5840.1239814027385, 5843.328017278068, 5853.5317174625925, 5856.092305692625, 5390.218418329398, 5493.176023596492, 5504.6421982571, 5566.443355664482, 5582.91625625616, 5614.326280846243, 5620.887582248332, 5634.070378387521, 5651.971740141273, 5681.4034526374135, 5613.691246981455, 5617.747201375948, 5620.91568626471, 5624.85937851557, 5630.042892708249, 5446.863828404322, 5572.024895643246, 5596.608237423423, 5602.775888964396, 5670.744816483269, 4240.342746874239, 4241.809118589671, 4289.485261768607, 4293.377460268243, 4327.3725309830525, 3873.6320049595806, 3877.263319969253, 3887.611238876146, 3924.1170736584613, 3928.057266256078, 5425.403205647375, 5425.755840987165, 5426.70153141581, 5427.728613569306, 5432.972835135878, 5615.129654903497, 5671.631343962629, 5672.829815105553, 5711.6001879868845, 5736.082226843769, 5426.782928682808, 5427.701476418756, 5430.891382172414, 5432.049391356497, 5469.644473109315, 4817.259186888134, 4854.563089321978, 4863.319135321058, 4866.075445665312, 4926.0, 5840.2991641003355, 5840.970795145997, 5855.180274761452, 5889.764409423747, 5893.764249429974, 5731.140328950691, 5760.279965004374, 5762.481376676119, 5817.243758311392, 5821.38875418075, 5874.4139082448355, 5908.409159084229, 5911.261092363455, 5912.0, 5920.259967504062, 5510.91733623988, 5571.916421253765, 5605.607607467601, 5637.126245431965, 5639.0, 5635.774569017193, 5667.546596272371, 5675.943240567542, 5689.203511508475, 5770.3364113125845, 5539.639923404966, 5571.637843540157, 5585.385607583082, 5594.944050559442, 5595.8880822384135, 5420.376656684374, 5585.69278689676, 5590.496855283044, 5597.272354593877, 5597.328320601554, 5461.863453413696, 5549.223108764857, 5561.555075594024, 5568.136938774496, 5568.944310557004, 5490.3411590609385, 5502.339719233558, 5519.751611177587, 5530.05988981866, 5535.308086489189, 5439.102548079522, 5446.809361672323, 5498.092814685532, 5499.917501237404, 5578.191162281528], "value": 5252.509416199937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.834553806627, 600.1447936690216, 603.0471854469935, 619.8822223777485, 633.2907143998721, 30796.0, 34028.659713402856, 34096.885467179934, 34098.488522672116, 41214.58785412145, 40471.392929106085, 44061.0, 44121.77939110308, 44225.55774442255, 44270.335944960774, 8825.779355516115, 8978.0, 8980.281577473786, 8982.550872456384, 8983.326250531203, 8135.837283254361, 8320.875186872172, 8824.955875220616, 8913.821723565525, 8914.687985920495, 8307.210814972597, 8362.038365587974, 10422.062014418701, 10761.62334318299, 10768.73078173044, 10680.51937662807, 10685.038346548808, 10742.0, 10748.677539673823, 10756.892431075745, 10661.573537058508, 10694.144468442584, 10722.249442539025, 10735.677929662123, 10775.515101820436, 41265.0, 41442.37836432456, 41789.0, 41865.58134418678, 41869.371959420634, 3395.422778127724, 3417.4019546579248, 3424.708899743525, 3543.698785603227, 3582.140286331288, 30923.536146957813, 31581.21046973821, 31717.84141079303, 33043.33913321744, 33448.6655133448, 4228.443449048153, 4290.099079193373, 4323.092150648367, 4357.651387888961, 4376.606105450493, 326882.9999999976, 327723.0, 328701.0, 328994.0, 329566.0, 57502.7124864373, 57764.42235577675, 57839.0, 57845.710771445876, 57886.4211357881, 35148.12129696727, 35678.82160589232, 35802.46296305557, 37902.43146352807, 61182.69408653017, 14551.708965820835, 14689.853101468849, 14703.117812931258, 14709.338079786436, 14714.484993025193, 10050.447225402528, 10059.144972677259, 10065.547050382751, 10066.396016238903, 10070.899291006996, 19426.396927732872, 19474.415767526996, 19523.01000911719, 19523.511912202026, 19525.36833031894, 5512.889742205133, 6736.360045795642, 6875.312468753084, 6928.411085057826, 7242.3843973262865, 889.5374405309203, 952.4190243951184, 978.3933960944261, 1022.2639699416557, 1176.9117316201318, 32089.51865722016, 32252.677473225438, 32497.51253731196, 32547.674523254937, 32619.836900815342, 1051.5793682526898, 1067.0, 1111.1610733895857, 1122.685648018556, 1183.928964262147, 16921.51374181924, 17009.829901700825, 17160.82839171617, 17185.0, 17316.307347706203, 435266.0, 438902.0, 438989.0, 439431.0, 440141.0, 59796.0, 60170.0, 60180.39819601835, 60262.0, 60314.39685603088, 1222.5109956017486, 1238.2508582307755, 1245.4395522014947, 1316.5260506217753, 1330.407968454048, 32893.50659740154, 34387.82806085954, 34392.312153756284, 35799.46300805438, 36311.45532816957, 54079.459205407446, 57448.71275643595, 59053.570982175646, 59168.408315918015, 65911.0, 445392.0, 456501.0, 457288.0, 457758.0, 458226.0, 43404.0, 43447.782761087255, 43523.0, 44348.556514434444, 45715.54284457113, 47871.76064119657, 48495.5150448491, 48539.514604854914, 49257.2611410822, 49497.50502494929, 40578.79710601428, 41509.58490415057, 41593.37609935914, 42127.789361053, 43565.34651980159, 41457.37813932854, 41654.148096761426, 41695.374569380874, 41765.490772252924, 42235.7888210557, 32674.50988235226, 33327.0, 33813.66186338203, 33891.32217355688, 34003.319933600695, 35126.12184695403, 36642.247128382674, 37112.0, 37634.24731505409, 37973.620263797005, 27641.585376219777, 28216.15351539457, 28299.575506367833, 28400.85799570989, 28472.857635712517], "value": 19926.319184945376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.2925734989547, 390.4260736717025, 397.09660522311736, 401.8894803928918, 415.6550063447339, 13118.0, 15196.392144314228, 16121.274542645566, 19410.126544305505, 19420.902895485502, 18481.0, 18790.718139227924, 19132.426027219204, 19466.0, 19468.41594752156, 5591.133374326976, 5729.512991395736, 5837.854053648672, 5845.415458454142, 5869.8239052828485, 3906.199229158016, 4085.1829634073156, 5644.238027866227, 5770.538356931456, 6146.262448506185, 6429.549931504796, 6487.286398496161, 6511.9348806512035, 6540.640264785435, 6550.410463058324, 5441.72119551905, 5649.519790817785, 5691.51622112121, 5810.535157187415, 6486.221653401599, 5449.427810079924, 5621.381648018714, 5628.943710562883, 5629.80295689653, 5633.8309850704545, 13603.523876664269, 14022.509212177525, 14032.649183770487, 14036.438542458289, 14052.648683782885, 2393.6529203265604, 2490.501899620065, 2563.4104156044214, 2653.0846857834017, 3004.53429718394, 14155.0, 15422.0, 15852.682946341123, 16178.676426471404, 16324.428644997368, 1934.3713293179633, 1939.3018513335187, 1949.512621844539, 1975.2743987003148, 2065.824404925583, 88680.0, 95702.0, 98023.0, 98245.0, 100220.49889750505, 17012.31950721982, 17111.401100961408, 17200.0, 17297.221625026905, 17535.580561790583, 31611.36777264442, 31726.496068305943, 31794.523082153788, 31918.202044948597, 31941.520877186395, 8867.822643547093, 8906.777330566787, 8928.375013748975, 9235.907640923504, 9240.122188392092, 7327.74352897646, 7457.32884040439, 7462.626868656654, 7541.321281084619, 7626.351760100342, 8622.879025726616, 8672.913270867211, 8701.521416322163, 8748.168923952215, 8903.821923561492, 2569.3833479964674, 3067.5550897157723, 3251.105945864906, 3285.852136653856, 3430.9485357719655, 424.8959005043784, 432.3989654380414, 442.69896470399794, 838.2748922182268, 898.3621628643606, 11741.823872641917, 12153.574624888086, 12245.69385765363, 12433.254004759743, 12447.564335248222, 438.3424862705941, 454.096348266953, 461.9769011549409, 469.1227404753133, 476.7640018191018, 6077.75688972445, 6368.617882926947, 6431.0, 6458.2895881453005, 6479.481641468671, 452446.0, 459319.0, 463664.0, 464814.0, 465824.0, 90871.0, 94371.52814235885, 94722.0, 94980.52509737546, 95379.0, 444.8198479615761, 965.280865755017, 1013.4527355228389, 1014.1633152649094, 1014.700663304327, 16281.185940703155, 16472.588185295463, 16714.16429178512, 17397.13014349303, 17718.91140544289, 41566.37650435185, 42209.0, 42603.5739642612, 43108.78445607877, 43397.132057359304, 52965.47034529605, 53207.46792532025, 53490.0, 60107.39892601018, 61397.38602614096, 8166.836663266583, 8175.959120204361, 8411.70559030431, 8429.199226073513, 8557.786055348666, 11028.503717332578, 12050.578229761917, 12560.560380386643, 12785.954247320384, 13025.804612930624, 10619.681409557727, 10697.893021069689, 11096.833547496633, 11263.718407039561, 11308.886911131112, 10500.369977801356, 10942.17933654995, 10955.452227388758, 11022.50398732043, 11114.44427778624, 10739.838902416313, 11290.830637540279, 11300.886991130312, 11445.771084578095, 11769.882301177222, 7267.200607933229, 7292.5624462530295, 7398.9630051851545, 7592.962035189788, 8728.869066964127, 9908.25688073383, 10766.946165269124, 10817.945910270399, 11216.495257713259, 11402.144839137263], "value": 9102.021751657923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.5588323502946, 1492.8432514585968, 1596.2338077722693, 1718.7679663245458, 1780.5192597998541, 7750.186230445806, 8030.357571394289, 8544.57277136143, 9159.542022898853, 9160.175584197412, 8499.362547808909, 8805.823883522326, 8807.339449541278, 8988.730338089868, 8997.325200609965, 2284.9200277990276, 2301.171578231835, 2317.3279748872806, 2338.3920180753043, 2346.4603141277516, 2025.1089520610883, 2081.43801173683, 2306.2735238399932, 2327.325075728037, 2374.361690433604, 2191.923282685106, 2248.786365295294, 2272.170657709932, 2275.6586512023246, 2286.554121946221, 2260.095961615367, 2269.171752310403, 2286.222684287342, 2287.2337766848127, 2306.5386922615376, 2273.7271527416815, 2288.599495088353, 2300.4363930836885, 2310.572544079351, 2316.5830150572892, 9048.864267036, 9224.815503689888, 9224.8616270756, 9226.40028398152, 9228.077192280785, 5157.53582177602, 5297.470252974672, 5304.310439642861, 5306.787728490855, 5309.203619457074, 3375.831208439593, 3383.8984830455124, 3386.373520898642, 3431.6396778338167, 3444.8622055117767, 1018.3991445047384, 1028.984565231522, 1029.1818004686218, 1041.1358572384902, 1042.062144070335, 12445.564405245863, 12633.747325053448, 12635.87364126356, 12673.176243544232, 12695.809562856564, 4373.387725718402, 4492.5507449255465, 4625.121226966866, 4647.697899636512, 4651.906961860744, 10629.362238265729, 10631.627893023708, 10647.361158330525, 10648.893511064945, 10667.253292269466, 5185.844424667266, 5190.455002224788, 5194.220866869924, 5196.064708352457, 5200.92198617021, 4706.1999460091865, 4708.0, 4739.478657347689, 4788.736619485892, 4795.544423279783, 3922.1763429679518, 3959.8812035638402, 4036.7779772112817, 4065.796710164539, 4106.7946602669745, 1157.1263695909702, 1191.9463624136936, 1301.7721898667885, 1303.850057243429, 1327.6083555351001, 818.5566085235567, 846.251067804997, 906.8322360363354, 941.1388579449864, 993.0218734546465, 5905.320888097838, 6013.51891848651, 6042.969785151046, 6089.817305480843, 6216.906746398808, 962.3696478806393, 973.4694591447678, 979.9167070799062, 985.5959056786826, 988.6737376665683, 3980.5621381647998, 4077.673786097105, 4087.570805065485, 4094.2220978014084, 4110.979445102756, 10417.374957502574, 10882.455877206266, 11311.095112390989, 11317.660470185907, 11332.830007549894, 10713.517891694892, 11184.217104802585, 11199.888001120047, 11200.21598488098, 11208.103351731841, 8170.182981701902, 8406.453580517247, 8472.237498625153, 8553.82892342162, 8562.143785621389, 6015.338312785678, 6115.877682446415, 6134.079888016833, 6172.074188871705, 6329.367063293634, 10243.897561024593, 10253.9487302566, 10356.896431035593, 10386.324888882198, 10444.63443779464, 10642.8403573948, 10782.514786834769, 10787.460626968777, 10802.621908233174, 10803.189760768131, 7821.55301269267, 7822.804429889298, 7836.568988705676, 7897.802554935943, 7917.643706033357, 8236.876446853183, 8237.670493180445, 8331.583420828812, 8333.541655209021, 8372.790680233044, 7441.925580744123, 7630.389568834591, 7631.122420921665, 7634.427417943565, 7906.367490600853, 7259.548090381839, 7367.447441441806, 7414.555126692416, 7428.517146385468, 7608.2391760823475, 6672.399484046459, 6778.3221677831825, 6788.694508747217, 6790.287019862843, 6792.490563207878, 4720.055988802184, 4865.659403841839, 4936.629752768628, 4974.278729584263, 5033.99320135967, 4705.106029854317, 4749.548792864673, 4808.567228949411, 4860.902781944412, 4933.087378834927], "value": 4624.287363854168, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2198406128128, 314.4042040333568, 318.0347644897735, 318.1632307032504, 322.1929067685449, 4900.460949295583, 5205.16717325228, 5386.757595908184, 5389.649672771267, 5402.810901618439, 5258.842234732954, 5357.49103835136, 5375.704336261504, 5376.650517716355, 5386.226093561819, 4219.493660760713, 4224.260754367973, 4224.5353011168745, 4228.788560571967, 4228.957710422903, 3944.447777311179, 4215.0, 4228.112096459748, 4238.4913810342805, 4238.618524332825, 3877.864274750384, 4113.177364527107, 4128.855490057848, 4137.151883863816, 4144.347617524787, 4108.952217184614, 4116.0, 4118.402831589433, 4119.114390406062, 4121.237571049365, 3637.6907962823193, 3645.38028535147, 3646.835892384849, 3651.032476393758, 3656.8171591420323, 5019.824306149304, 5194.68831870089, 5237.292965449692, 5242.528172464458, 5258.6318957672975, 4719.669623126382, 4725.3384526166365, 4729.905401891977, 4733.715977041388, 4742.976285118552, 5631.662100273997, 5641.746121424505, 5641.774329026875, 5648.265725455705, 5666.121751128581, 3787.772733635963, 3915.7846318452475, 3947.210557888405, 3967.4842270504937, 3971.721979461439, 5546.4453554644615, 5683.516901063374, 5830.970845145789, 5849.444302791228, 5865.856158049182, 3887.339152344052, 3899.941500877489, 3909.354956432214, 3909.9413508797393, 3953.723239373274, 4068.9248483273745, 4094.447249621263, 4099.323611604112, 4099.508059032935, 4108.568600296986, 4618.538146185355, 4711.128441238382, 4712.4317247099725, 4713.198756211452, 4744.312074749211, 5597.692126933058, 5618.280644258761, 5636.408177141423, 5638.633488823213, 5667.263255776723, 1390.1728471559406, 1402.1727180963076, 1403.733290674789, 1409.8801601863956, 1410.9435622574981, 839.7858546070835, 884.6903583745766, 895.2185151548372, 902.7652810269246, 903.8599017152352, 4724.95275047252, 4769.284607308931, 4790.5448982346625, 4803.78382972767, 4811.374521312207, 5059.62052846038, 5091.490850914953, 5094.032133894548, 5103.668261562986, 5112.821051263188, 4583.479086502411, 4761.9759360286425, 4767.451743049524, 4799.256115302133, 4815.735134567562, 2718.4019515706514, 2721.67339919207, 2736.616873637692, 2753.366725653111, 2757.834529928211, 5139.357580302462, 5147.279380886679, 5155.432902380735, 5164.244156986642, 5178.741062946838, 4866.343043689128, 4977.565830806291, 5048.116579598555, 5073.959838233153, 5086.872828179326, 5117.7758012453405, 5138.2292656101135, 5158.303629010111, 5165.760217547837, 5251.0, 5011.874703132451, 5020.47285035066, 5032.62255330859, 5033.823816166417, 5043.344365232496, 4987.376577927759, 4991.750412479434, 5234.345706786652, 5676.460736230051, 5758.675504633874, 5668.489835914787, 5789.884202316014, 5815.45890339052, 5953.28560572734, 5960.3443621202505, 4111.9177616446905, 4115.1975364803575, 4137.54487006423, 4147.65657403566, 4156.8129434174925, 5766.857062900813, 5870.7945221917025, 5872.0, 5874.736931559735, 5890.352061273171, 5548.750306236309, 5602.4957753802355, 5604.663720176803, 5641.661500309994, 5645.209670646195, 5590.385057643574, 5612.214289999321, 5624.550035997192, 5660.54715622741, 5687.857803554944, 5411.485908838654, 5642.407547207484, 5652.971735141463, 5673.659580425187, 5696.724383479599, 5610.803621873215, 5651.491365777099, 5675.375708671961, 5677.914831277451, 5707.6290041147195, 5528.723563821713, 5552.666839989613, 5554.305711786027, 5558.166275058774, 5581.386047534849], "value": 4123.4409580291485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.1784512120818, 712.1596516110988, 745.4264670943218, 779.2800841821032, 800.5236884053987, 12836.935815320921, 12869.5495657652, 12933.611991640266, 12992.675183120427, 13020.0, 12162.087843411735, 12320.075994300441, 12345.444454999524, 12576.874231257685, 13267.004974626894, 791.3431851563203, 803.1286054630733, 803.1927912447982, 803.895493585833, 804.5132694719698, 656.2846497317922, 674.1101745695684, 778.2412148155531, 802.9598520074002, 805.8670319397293, 847.4237518487427, 856.7044369692477, 858.0947100808644, 858.5149390594325, 859.0893652728097, 840.7141571865565, 848.6690190825583, 849.0702680564772, 849.2399302624148, 850.1158794853345, 502.1964856230039, 518.582541054451, 595.6396380190009, 619.7520991603395, 621.0094898636668, 13204.207747535178, 13813.930930345285, 13876.375563099584, 13877.0, 13902.582922512342, 12253.877461225451, 12607.369631518479, 12645.17806342594, 12840.935795320964, 12919.870801292054, 11018.0, 11058.723531911686, 11154.386508742016, 11241.494132763963, 11422.94288528552, 4228.386883901848, 4250.171216612762, 4279.764612946286, 4333.934990975138, 4497.685162038659, 64752.352476475106, 65584.0, 66692.0, 66892.3310766891, 67333.0, 10554.208434367452, 10635.840462393071, 10822.026017658449, 10844.295120817122, 11101.44492775358, 19204.63918814202, 19225.32711355096, 19239.13423895928, 19254.422367329003, 20750.169993200103, 7706.691732330644, 7746.30283274508, 7873.724419645285, 7889.447738658238, 7915.76252712408, 4327.437433133672, 4377.890552736207, 4379.97070688388, 4401.691881568324, 4531.728096314232, 3301.4552598821406, 3404.8638054478038, 3406.2506248625264, 3408.9488657670154, 3409.488576713513, 601.8615718384796, 616.9259688837368, 623.2365352443221, 628.632250133677, 653.2944420026361, 696.5716084608031, 696.6795274173835, 698.4447364345256, 737.1265050914683, 739.8002539314463, 8748.650053997897, 9340.299477539213, 9491.335606507617, 9614.423134611945, 9771.609135634637, 663.2770280394393, 680.2143524229523, 702.8664553734876, 703.549728173969, 704.8378872859271, 4032.334286780251, 4244.745315281093, 4272.722273052242, 4304.817366851802, 4467.0, 85664.0, 89845.55077224702, 90056.0, 90844.54577727201, 93927.0, 64431.0, 64806.351936480976, 78041.90350495682, 79099.0, 80821.19178808137, 41413.58586414097, 50498.0, 53761.46238537643, 57986.999999999156, 63755.36244637587, 9122.270218382646, 9398.342116052085, 9412.48231347255, 9558.95220523893, 9648.421094734338, 40393.39409908795, 41791.16417671569, 43445.348319774595, 43586.782066089465, 44298.335524966504, 40346.59653403428, 40646.39030414487, 45369.54630453785, 57453.0, 60706.0, 11666.591669291534, 11800.527978881091, 11822.625628517504, 12062.0, 12931.612051638465, 13342.381478380934, 13509.72980540364, 13932.30338483092, 13981.510647127301, 14063.859361406256, 12702.428390722254, 12849.51570047713, 13029.869701302865, 13050.802553374484, 13560.660983475493, 12026.218295810744, 12480.913759939516, 12616.405217348078, 12875.484980601046, 13764.036517443683, 12120.393980301125, 12327.445264963277, 12483.581463409777, 12985.935070324587, 13288.667783305495, 10182.389056656624, 10296.433696146783, 10444.58998035286, 10569.577216911237, 10686.198535110054, 10616.734581635212, 11199.66401007971, 11308.49111789988, 11385.715357116138, 11635.650930472098], "value": 6883.966363578125, "unit": "score"}], "name": "dromaeo_css", "value": 7071.640785111687, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 121.0, 162.0, 125.0, 128.0, 126.0, 133.0, 161.0, 127.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 163.0, 163.0, 162.0, 164.0, 164.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 114.0, 76.0, 76.0, 77.0, 76.0, 101.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 82.0, 82.0, 81.0, 103.0, 82.0, 82.0, 106.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 84.0, 83.0, 84.0, 85.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 52.0, 54.0, 54.0, 52.0, 55.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 80.0, 82.0, 79.0, 79.0, 78.0, 87.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 132.0, 130.0, 134.0, 136.0, 135.0, 129.0, 165.0, 131.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 165.0, 163.0, 165.0, 165.0, 164.0, 162.0, 165.0, 166.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 64.0, 64.0, 66.0, 66.0, 63.0, 64.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1485.3, "alertThreshold": 2.0}]} 13:52:11 INFO - Return code: 0 13:52:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:52:11 INFO - # TBPL SUCCESS # 13:52:11 INFO - Running post-action listener: _resource_record_post_action 13:52:11 INFO - [mozharness: 2016-10-26 20:52:11.753967Z] Finished run-tests step (success) 13:52:11 INFO - Running post-run listener: _resource_record_post_run 13:52:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391966720; Read time: 20; Write time: 355508 13:52:11 INFO - TinderboxPrint: CPU usage
13.1% 13:52:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 13:52:11 INFO - TinderboxPrint: I/O write bytes / time
391,966,720 / 355,508 13:52:11 INFO - TinderboxPrint: CPU idle
8,290.0 (86.9%) 13:52:11 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 13:52:11 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103538688; Read time: 0; Write time: 121136 13:52:11 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288100352; Read time: 0; Write time: 234372 13:52:12 INFO - Running post-run listener: _upload_blobber_files 13:52:12 INFO - Blob upload gear active. 13:52:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:52:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:52:12 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:52:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:52:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:13 INFO - (blobuploader) - INFO - Done attempting. 13:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:17 INFO - (blobuploader) - INFO - Done attempting. 13:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:18 INFO - (blobuploader) - INFO - Done attempting. 13:52:18 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:18 INFO - Return code: 0 13:52:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1e7fbcf5bdb78774e855445327750e0b8fb63b82cbe794f4c3cc4b5a0ee3c8d68a38749cca1c9b10068841bb2a365257bc9e10534a7b617896bb8998d6712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eacaf55fec2e4888a53f5340cd42092fb99e94538cd779d42a4c6f310077e413582d719a4fbf54cc9b8aacf79679ffde58ffb64951fbe0ffe10048c67f602f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/454025c8dcebf91b89dc6738af612e289a0e51e3b1151884ab8e611555c9c9c2565cc9dcabdb5ecb89439db48ad068ce636759cd4ab77b13ca0237a32fb8b51e"} 13:52:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:18 INFO - Contents: 13:52:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1e7fbcf5bdb78774e855445327750e0b8fb63b82cbe794f4c3cc4b5a0ee3c8d68a38749cca1c9b10068841bb2a365257bc9e10534a7b617896bb8998d6712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eacaf55fec2e4888a53f5340cd42092fb99e94538cd779d42a4c6f310077e413582d719a4fbf54cc9b8aacf79679ffde58ffb64951fbe0ffe10048c67f602f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/454025c8dcebf91b89dc6738af612e289a0e51e3b1151884ab8e611555c9c9c2565cc9dcabdb5ecb89439db48ad068ce636759cd4ab77b13ca0237a32fb8b51e"} 13:52:18 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:18 INFO - Copying logs to upload dir... 13:52:18 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.370103 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-26 13:52:17.850253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 13:52:17.853823) ========= 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=826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1e7fbcf5bdb78774e855445327750e0b8fb63b82cbe794f4c3cc4b5a0ee3c8d68a38749cca1c9b10068841bb2a365257bc9e10534a7b617896bb8998d6712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eacaf55fec2e4888a53f5340cd42092fb99e94538cd779d42a4c6f310077e413582d719a4fbf54cc9b8aacf79679ffde58ffb64951fbe0ffe10048c67f602f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/454025c8dcebf91b89dc6738af612e289a0e51e3b1151884ab8e611555c9c9c2565cc9dcabdb5ecb89439db48ad068ce636759cd4ab77b13ca0237a32fb8b51e"} build_url:https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011568 build_url: 'https://queue.taskcluster.net/v1/task/CZdTn8hnQiaW3SDWTe8Ysg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80e1e7fbcf5bdb78774e855445327750e0b8fb63b82cbe794f4c3cc4b5a0ee3c8d68a38749cca1c9b10068841bb2a365257bc9e10534a7b617896bb8998d6712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eacaf55fec2e4888a53f5340cd42092fb99e94538cd779d42a4c6f310077e413582d719a4fbf54cc9b8aacf79679ffde58ffb64951fbe0ffe10048c67f602f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/454025c8dcebf91b89dc6738af612e289a0e51e3b1151884ab8e611555c9c9c2565cc9dcabdb5ecb89439db48ad068ce636759cd4ab77b13ca0237a32fb8b51e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 13:52:17.879266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:52:17.879606) ========= 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=826874ccc97bd7bf541b4875000001d5-1477513896.539912-1160746822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:52:17.963524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 13:52:17.963836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 13:52:17.964136) ========= ========= Total master_lag: 0.16 =========