builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1486402369.43 results: success (0) buildid: 20170206072151 builduid: 38aa74bb32b54f2e8659bfdfde07dade revision: 9a1b79873db7526a0c9f33511e224a617af7ca6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.425918) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.426335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.426605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.442892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.443227) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 09:32:49-- 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% 39.0K=0.3s 2017-02-06 09:32:50 (39.0 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.396125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.852773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.853097) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013764 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:49.902882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 09:32:49.903245) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9a1b79873db7526a0c9f33511e224a617af7ca6b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9a1b79873db7526a0c9f33511e224a617af7ca6b --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=5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 09:32:50,412 truncating revision to first 12 chars 2017-02-06 09:32:50,412 Setting DEBUG logging. 2017-02-06 09:32:50,412 attempt 1/10 2017-02-06 09:32:50,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9a1b79873db7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 09:32:51,272 unpacking tar archive at: mozilla-beta-9a1b79873db7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.254529 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 09:32:51.171506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:51.171827) ========= script_repo_revision: 9a1b79873db7526a0c9f33511e224a617af7ca6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:51.172216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:51.172477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 09:32:51.182386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-06 09:32:51.182680) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:51 INFO - MultiFileLogger online at 20170206 09:32:51 in /builds/slave/test 09:32:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:32:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:51 INFO - {'append_to_log': False, 09:32:51 INFO - 'base_work_dir': '/builds/slave/test', 09:32:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:32:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:51 INFO - 'branch': 'Mozilla-Beta', 09:32:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:51 INFO - 'config_files': ('talos/linux_config.py',), 09:32:51 INFO - 'default_actions': ('clobber', 09:32:51 INFO - 'read-buildbot-config', 09:32:51 INFO - 'download-and-extract', 09:32:51 INFO - 'populate-webroot', 09:32:51 INFO - 'create-virtualenv', 09:32:51 INFO - 'install', 09:32:51 INFO - 'run-tests'), 09:32:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:51 INFO - 'download_minidump_stackwalk': True, 09:32:51 INFO - 'download_symbols': 'ondemand', 09:32:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:51 INFO - 'installer_path': 'installer.exe', 09:32:51 INFO - 'log_level': 'info', 09:32:51 INFO - 'log_name': 'talos', 09:32:51 INFO - 'log_to_console': True, 09:32:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:51 INFO - 'opt_config_files': (), 09:32:51 INFO - 'pip_index': False, 09:32:51 INFO - 'sps_profile': False, 09:32:51 INFO - 'sps_profile_interval': 0, 09:32:51 INFO - 'suite': 'dromaeojs', 09:32:51 INFO - 'system_bits': '32', 09:32:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:51 INFO - 'title': 'talos-linux64-ix-051', 09:32:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:51 INFO - 'use_talos_json': True, 09:32:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:51 INFO - 'work_dir': 'build'} 09:32:51 INFO - [mozharness: 2017-02-06 17:32:51.778576Z] Running clobber step. 09:32:51 INFO - Running pre-action listener: _resource_record_pre_action 09:32:51 INFO - Running main action method: clobber 09:32:51 INFO - rmtree: /builds/slave/test/build 09:32:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:52 INFO - Running post-action listener: _resource_record_post_action 09:32:52 INFO - [mozharness: 2017-02-06 17:32:52.311722Z] Finished clobber step (success) 09:32:52 INFO - [mozharness: 2017-02-06 17:32:52.311823Z] Running read-buildbot-config step. 09:32:52 INFO - Running pre-action listener: _resource_record_pre_action 09:32:52 INFO - Running main action method: read_buildbot_config 09:32:52 INFO - Using buildbot properties: 09:32:52 INFO - { 09:32:52 INFO - "project": "", 09:32:52 INFO - "product": "firefox", 09:32:52 INFO - "script_repo_revision": "production", 09:32:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:32:52 INFO - "repository": "", 09:32:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:32:52 INFO - "buildid": "20170206072151", 09:32:52 INFO - "pgo_build": "True", 09:32:52 INFO - "basedir": "/builds/slave/test", 09:32:52 INFO - "buildnumber": 5, 09:32:52 INFO - "slavename": "talos-linux64-ix-051", 09:32:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:32:52 INFO - "platform": "ubuntu64_hw", 09:32:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:32:52 INFO - "branch": "mozilla-beta", 09:32:52 INFO - "repo_path": "releases/mozilla-beta", 09:32:52 INFO - "revision": "9a1b79873db7526a0c9f33511e224a617af7ca6b", 09:32:52 INFO - "stage_platform": "linux64-pgo", 09:32:52 INFO - "builduid": "38aa74bb32b54f2e8659bfdfde07dade", 09:32:52 INFO - "slavebuilddir": "test" 09:32:52 INFO - } 09:32:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 09:32:52 INFO - Running post-action listener: _resource_record_post_action 09:32:52 INFO - [mozharness: 2017-02-06 17:32:52.314297Z] Finished read-buildbot-config step (success) 09:32:52 INFO - [mozharness: 2017-02-06 17:32:52.314386Z] Running download-and-extract step. 09:32:52 INFO - Running pre-action listener: _resource_record_pre_action 09:32:52 INFO - Running main action method: download_and_extract 09:32:52 INFO - mkdir: /builds/slave/test/build/tests 09:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:52 INFO - trying https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:32:52 INFO - Downloading https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:32:52 INFO - Downloaded 1327 bytes. 09:32:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 09:32:52 INFO - Using the following test package requirements: 09:32:52 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:32:52 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:32:52 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 09:32:52 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'jsshell-linux-x86_64.zip'], 09:32:52 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:32:52 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 09:32:52 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 09:32:52 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 09:32:52 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:32:52 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 09:32:52 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:32:52 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:32:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:32:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:52 INFO - Fetch https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:32:53 INFO - Http code: 200 09:32:53 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 09:32:53 INFO - x-amz-cf-id: lvTotF-UXCn1Di_jknDXthwajKch5jNuUK8Tqxi_fXx660d5so0wfg== 09:32:53 INFO - x-amz-version-id: G8BKEmd4I4B3AY6ygHmvky90XzK6B5om 09:32:53 INFO - Expected file size: 21955827 09:32:53 INFO - Obtained file size: 21955827 09:32:57 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:32:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 09:32:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:57 INFO - Fetch https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 09:32:58 INFO - Http code: 200 09:32:58 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 09:32:58 INFO - x-amz-cf-id: BXc36Yq_li7S9QlGGapnbJBW9O6SL4_cs7BG5Xt9TVH5-OcbmoaCdw== 09:32:58 INFO - x-amz-version-id: G8BKEmd4I4B3AY6ygHmvky90XzK6B5om 09:32:58 INFO - Expected file size: 21955827 09:32:58 INFO - Obtained file size: 21955827 09:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 09:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 09:33:03 INFO - Http code: 200 09:33:03 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 09:33:03 INFO - x-amz-cf-id: 6lljrbtXJku6nNjqTb6ImSafm9xszk8lkwmAj-kXQbX8yGggccui3Q== 09:33:03 INFO - x-amz-version-id: IrShJ_G1K9Ft979RQ26vZ9tCWIZbz_B4 09:33:03 INFO - Expected file size: 14403005 09:33:03 INFO - Obtained file size: 14403005 09:33: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')]} 09:33:04 INFO - trying https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:33:05 INFO - Downloaded 57719284 bytes. 09:33:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:33:05 INFO - mkdir: /builds/slave/test/properties 09:33:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:05 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:05 INFO - Contents: 09:33:05 INFO - build_url:https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 09:33:06 INFO - Running post-action listener: _resource_record_post_action 09:33:06 INFO - Running post-action listener: set_extra_try_arguments 09:33:06 INFO - [mozharness: 2017-02-06 17:33:06.517069Z] Finished download-and-extract step (success) 09:33:06 INFO - [mozharness: 2017-02-06 17:33:06.517297Z] Running populate-webroot step. 09:33:06 INFO - Running pre-action listener: _resource_record_pre_action 09:33:06 INFO - Running main action method: populate_webroot 09:33:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:06 INFO - '--tppagecycles', 09:33:06 INFO - '7'], 09:33:06 INFO - 'tests': ['tsvgm']}}, 09:33:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['damp', 'tps']}, 09:33:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'tests': ['damp', 'tps']}, 09:33:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['dromaeo_dom']}, 09:33:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['basic_compositor_video']}, 09:33:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:33:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['a11yr', 09:33:06 INFO - 'ts_paint', 09:33:06 INFO - 'tpaint', 09:33:06 INFO - 'sessionrestore', 09:33:06 INFO - 'sessionrestore_no_auto_restore', 09:33:06 INFO - 'tabpaint']}, 09:33:06 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:06 INFO - 'ts_paint', 09:33:06 INFO - 'tpaint', 09:33:06 INFO - 'sessionrestore', 09:33:06 INFO - 'sessionrestore_no_auto_restore', 09:33:06 INFO - 'tabpaint']}, 09:33:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:06 INFO - 'ts_paint', 09:33:06 INFO - 'tpaint', 09:33:06 INFO - 'sessionrestore', 09:33:06 INFO - 'sessionrestore_no_auto_restore', 09:33:06 INFO - 'tabpaint']}, 09:33:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:06 INFO - 'ts_paint', 09:33:06 INFO - 'tpaint', 09:33:06 INFO - 'sessionrestore', 09:33:06 INFO - 'sessionrestore_no_auto_restore', 09:33:06 INFO - 'tabpaint']}, 09:33:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['a11yr', 09:33:06 INFO - 'ts_paint', 09:33:06 INFO - 'tpaint', 09:33:06 INFO - 'sessionrestore', 09:33:06 INFO - 'sessionrestore_no_auto_restore', 09:33:06 INFO - 'tabpaint']}, 09:33:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['a11yr', 09:33:06 INFO - 'ts_paint', 09:33:06 INFO - 'tpaint', 09:33:06 INFO - 'sessionrestore', 09:33:06 INFO - 'sessionrestore_no_auto_restore', 09:33:06 INFO - 'tabpaint']}, 09:33:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['tsvgx', 09:33:06 INFO - 'tsvgr_opacity', 09:33:06 INFO - 'tart', 09:33:06 INFO - 'tscrollx', 09:33:06 INFO - 'cart']}, 09:33:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:06 INFO - 'tsvgr_opacity', 09:33:06 INFO - 'tart', 09:33:06 INFO - 'tscrollx', 09:33:06 INFO - 'cart']}, 09:33:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'talos_options': ['--disable-e10s'], 09:33:06 INFO - 'tests': ['tp5o']}, 09:33:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'tests': ['tp5o']}, 09:33:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'talos_options': ['--disable-e10s', 09:33:06 INFO - '--xperf_path', 09:33:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:06 INFO - 'tests': ['tp5n']}, 09:33:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:06 INFO - 'talos_options': ['--xperf_path', 09:33:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:06 INFO - 'tests': ['tp5n']}}, 09:33:06 INFO - 'talos.zip': {'path': '', 09:33:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:06 INFO - Running post-action listener: _resource_record_post_action 09:33:06 INFO - [mozharness: 2017-02-06 17:33:06.533714Z] Finished populate-webroot step (success) 09:33:06 INFO - [mozharness: 2017-02-06 17:33:06.533803Z] Running create-virtualenv step. 09:33:06 INFO - Running pre-action listener: _resource_record_pre_action 09:33:06 INFO - Running main action method: create_virtualenv 09:33:06 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:06 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 09:33:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:06 INFO - Using real prefix '/usr' 09:33:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:09 INFO - Installing pip.................done. 09:33:09 INFO - Return code: 0 09:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:09 INFO - Reading from file tmpfile_stdout 09:33:09 INFO - Output received: 09:33:09 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) 09:33:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:09 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')]} 09:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:09 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')]} 09:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:09 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:09 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 09:33:09 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 09:33:09 INFO - Using env: {'DISPLAY': ':0', 09:33:09 INFO - 'HOME': '/home/cltbld', 09:33:09 INFO - 'LANG': 'en_US.UTF-8', 09:33:09 INFO - 'LANGUAGE': 'en_US:en', 09:33:09 INFO - 'LOGNAME': 'cltbld', 09:33:09 INFO - 'MAIL': '/var/mail/cltbld', 09:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:09 INFO - 'MOZ_NO_REMOTE': '1', 09:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:09 INFO - 'NO_EM_RESTART': '1', 09:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:09 INFO - 'PWD': '/builds/slave/test', 09:33:09 INFO - 'SHELL': '/bin/bash', 09:33:09 INFO - 'SHLVL': '1', 09:33:09 INFO - 'TERM': 'linux', 09:33:09 INFO - 'TMOUT': '86400', 09:33:09 INFO - 'USER': 'cltbld', 09:33:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:09 INFO - '_': '/tools/buildbot/bin/python'} 09:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:09 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 09:33:09 INFO - Cleaning up... 09:33:09 INFO - Return code: 0 09:33:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:09 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')]} 09:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:09 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')]} 09:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:09 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:09 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 09:33:09 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 09:33:09 INFO - Using env: {'DISPLAY': ':0', 09:33:09 INFO - 'HOME': '/home/cltbld', 09:33:09 INFO - 'LANG': 'en_US.UTF-8', 09:33:09 INFO - 'LANGUAGE': 'en_US:en', 09:33:09 INFO - 'LOGNAME': 'cltbld', 09:33:09 INFO - 'MAIL': '/var/mail/cltbld', 09:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:09 INFO - 'MOZ_NO_REMOTE': '1', 09:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:09 INFO - 'NO_EM_RESTART': '1', 09:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:09 INFO - 'PWD': '/builds/slave/test', 09:33:09 INFO - 'SHELL': '/bin/bash', 09:33:09 INFO - 'SHLVL': '1', 09:33:09 INFO - 'TERM': 'linux', 09:33:09 INFO - 'TMOUT': '86400', 09:33:09 INFO - 'USER': 'cltbld', 09:33:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:09 INFO - '_': '/tools/buildbot/bin/python'} 09:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:09 INFO - Downloading/unpacking psutil>=3.1.1 09:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:11 INFO - Installing collected packages: psutil 09:33:11 INFO - Running setup.py install for psutil 09:33:11 INFO - building 'psutil._psutil_linux' extension 09:33:11 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 09:33:12 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 09:33:12 INFO - building 'psutil._psutil_posix' extension 09:33:12 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 09:33:12 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 09:33:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:12 INFO - Successfully installed psutil 09:33:12 INFO - Cleaning up... 09:33:12 INFO - Return code: 0 09:33:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:12 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')]} 09:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:12 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')]} 09:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:12 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:12 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 09:33:12 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 09:33:12 INFO - Using env: {'DISPLAY': ':0', 09:33:12 INFO - 'HOME': '/home/cltbld', 09:33:12 INFO - 'LANG': 'en_US.UTF-8', 09:33:12 INFO - 'LANGUAGE': 'en_US:en', 09:33:12 INFO - 'LOGNAME': 'cltbld', 09:33:12 INFO - 'MAIL': '/var/mail/cltbld', 09:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:12 INFO - 'MOZ_NO_REMOTE': '1', 09:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:12 INFO - 'NO_EM_RESTART': '1', 09:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:12 INFO - 'PWD': '/builds/slave/test', 09:33:12 INFO - 'SHELL': '/bin/bash', 09:33:12 INFO - 'SHLVL': '1', 09:33:12 INFO - 'TERM': 'linux', 09:33:12 INFO - 'TMOUT': '86400', 09:33:12 INFO - 'USER': 'cltbld', 09:33:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:12 INFO - '_': '/tools/buildbot/bin/python'} 09:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:14 INFO - Installing collected packages: mozsystemmonitor 09:33:14 INFO - Running setup.py install for mozsystemmonitor 09:33:14 INFO - Successfully installed mozsystemmonitor 09:33:14 INFO - Cleaning up... 09:33:14 INFO - Return code: 0 09:33:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:33:14 INFO - Using env: {'DISPLAY': ':0', 09:33:14 INFO - 'HOME': '/home/cltbld', 09:33:14 INFO - 'LANG': 'en_US.UTF-8', 09:33:14 INFO - 'LANGUAGE': 'en_US:en', 09:33:14 INFO - 'LOGNAME': 'cltbld', 09:33:14 INFO - 'MAIL': '/var/mail/cltbld', 09:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:14 INFO - 'MOZ_NO_REMOTE': '1', 09:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:14 INFO - 'NO_EM_RESTART': '1', 09:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:14 INFO - 'PWD': '/builds/slave/test', 09:33:14 INFO - 'SHELL': '/bin/bash', 09:33:14 INFO - 'SHLVL': '1', 09:33:14 INFO - 'TERM': 'linux', 09:33:14 INFO - 'TMOUT': '86400', 09:33:14 INFO - 'USER': 'cltbld', 09:33:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:14 INFO - '_': '/tools/buildbot/bin/python'} 09:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:15 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 09:33:15 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 09:33:15 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 09:33:15 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 09:33:15 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 09:33:15 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 09:33:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:17 INFO - warning: no files found matching '*.txt' 09:33:17 INFO - no previously-included directories found matching 'build' 09:33:17 INFO - no previously-included directories found matching 'dist' 09:33:17 INFO - no previously-included directories found matching '.git*' 09:33:17 INFO - Installing collected packages: jsonschema, functools32 09:33:17 INFO - Running setup.py install for functools32 09:33:17 INFO - warning: no files found matching '*.txt' 09:33:17 INFO - no previously-included directories found matching 'build' 09:33:17 INFO - no previously-included directories found matching 'dist' 09:33:17 INFO - no previously-included directories found matching '.git*' 09:33:17 INFO - Successfully installed jsonschema functools32 09:33:17 INFO - Cleaning up... 09:33:17 INFO - Return code: 0 09:33:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:33:17 INFO - Using env: {'DISPLAY': ':0', 09:33:17 INFO - 'HOME': '/home/cltbld', 09:33:17 INFO - 'LANG': 'en_US.UTF-8', 09:33:17 INFO - 'LANGUAGE': 'en_US:en', 09:33:17 INFO - 'LOGNAME': 'cltbld', 09:33:17 INFO - 'MAIL': '/var/mail/cltbld', 09:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:17 INFO - 'MOZ_NO_REMOTE': '1', 09:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:17 INFO - 'NO_EM_RESTART': '1', 09:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:17 INFO - 'PWD': '/builds/slave/test', 09:33:17 INFO - 'SHELL': '/bin/bash', 09:33:17 INFO - 'SHLVL': '1', 09:33:17 INFO - 'TERM': 'linux', 09:33:17 INFO - 'TMOUT': '86400', 09:33:17 INFO - 'USER': 'cltbld', 09:33:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:17 INFO - '_': '/tools/buildbot/bin/python'} 09:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:17 INFO - Cleaning up... 09:33:17 INFO - Return code: 0 09:33:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:17 INFO - Using env: {'DISPLAY': ':0', 09:33:17 INFO - 'HOME': '/home/cltbld', 09:33:17 INFO - 'LANG': 'en_US.UTF-8', 09:33:17 INFO - 'LANGUAGE': 'en_US:en', 09:33:17 INFO - 'LOGNAME': 'cltbld', 09:33:17 INFO - 'MAIL': '/var/mail/cltbld', 09:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:17 INFO - 'MOZ_NO_REMOTE': '1', 09:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:17 INFO - 'NO_EM_RESTART': '1', 09:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:17 INFO - 'PWD': '/builds/slave/test', 09:33:17 INFO - 'SHELL': '/bin/bash', 09:33:17 INFO - 'SHLVL': '1', 09:33:17 INFO - 'TERM': 'linux', 09:33:17 INFO - 'TMOUT': '86400', 09:33:17 INFO - 'USER': 'cltbld', 09:33:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:17 INFO - '_': '/tools/buildbot/bin/python'} 09:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:18 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 09:33:18 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 09:33:18 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 09:33:18 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 09:33:18 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 09:33:18 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 09:33:20 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 INFO - Downloading docopt-0.6.1.tar.gz 09:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:20 INFO - Running setup.py install for blobuploader 09:33:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:20 INFO - Running setup.py install for requests 09:33:21 INFO - Running setup.py install for docopt 09:33:21 INFO - Successfully installed blobuploader requests docopt 09:33:21 INFO - Cleaning up... 09:33:21 INFO - Return code: 0 09:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:21 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:21 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 09:33:21 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 09:33:21 INFO - Using env: {'DISPLAY': ':0', 09:33:21 INFO - 'HOME': '/home/cltbld', 09:33:21 INFO - 'LANG': 'en_US.UTF-8', 09:33:21 INFO - 'LANGUAGE': 'en_US:en', 09:33:21 INFO - 'LOGNAME': 'cltbld', 09:33:21 INFO - 'MAIL': '/var/mail/cltbld', 09:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:21 INFO - 'MOZ_NO_REMOTE': '1', 09:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:21 INFO - 'NO_EM_RESTART': '1', 09:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:21 INFO - 'PWD': '/builds/slave/test', 09:33:21 INFO - 'SHELL': '/bin/bash', 09:33:21 INFO - 'SHLVL': '1', 09:33:21 INFO - 'TERM': 'linux', 09:33:21 INFO - 'TMOUT': '86400', 09:33:21 INFO - 'USER': 'cltbld', 09:33:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:21 INFO - '_': '/tools/buildbot/bin/python'} 09:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:21 INFO - Running setup.py (path:/tmp/pip-2WM0RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:21 INFO - Running setup.py (path:/tmp/pip-4oN9r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:21 INFO - Running setup.py (path:/tmp/pip-_ZpxpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:21 INFO - Running setup.py (path:/tmp/pip-7AeS5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:21 INFO - Running setup.py (path:/tmp/pip-JguhQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:22 INFO - Running setup.py (path:/tmp/pip-IT2X8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:22 INFO - Running setup.py (path:/tmp/pip-4MZEfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:22 INFO - Running setup.py (path:/tmp/pip-WJ4YMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:22 INFO - Running setup.py (path:/tmp/pip-nMUc43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:22 INFO - Running setup.py (path:/tmp/pip-8_Nzpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:22 INFO - Running setup.py (path:/tmp/pip-Uz5cOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:22 INFO - Running setup.py (path:/tmp/pip-tGXgRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:22 INFO - Running setup.py (path:/tmp/pip-A2mBcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:22 INFO - Running setup.py (path:/tmp/pip-xr3lCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:22 INFO - Running setup.py (path:/tmp/pip-XKO2R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:22 INFO - Running setup.py (path:/tmp/pip-fzutRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:22 INFO - Running setup.py (path:/tmp/pip-v5h0ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:22 INFO - Running setup.py install for manifestparser 09:33:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:22 INFO - Running setup.py install for mozcrash 09:33:23 INFO - Running setup.py install for mozdebug 09:33:23 INFO - Running setup.py install for mozdevice 09:33:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Running setup.py install for mozfile 09:33:23 INFO - Running setup.py install for mozhttpd 09:33:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Running setup.py install for mozinfo 09:33:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Running setup.py install for mozInstall 09:33:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Running setup.py install for mozleak 09:33:23 INFO - Running setup.py install for mozlog 09:33:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:23 INFO - Running setup.py install for moznetwork 09:33:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:24 INFO - Running setup.py install for mozprocess 09:33:24 INFO - Running setup.py install for mozprofile 09:33:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:24 INFO - Running setup.py install for mozrunner 09:33:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:24 INFO - Running setup.py install for mozscreenshot 09:33:24 INFO - Running setup.py install for moztest 09:33:24 INFO - Running setup.py install for mozversion 09:33:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:24 INFO - Cleaning up... 09:33:24 INFO - Return code: 0 09:33:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:24 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')]} 09:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:24 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')]} 09:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:24 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:24 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 09:33:24 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 09:33:24 INFO - Using env: {'DISPLAY': ':0', 09:33:24 INFO - 'HOME': '/home/cltbld', 09:33:24 INFO - 'LANG': 'en_US.UTF-8', 09:33:24 INFO - 'LANGUAGE': 'en_US:en', 09:33:24 INFO - 'LOGNAME': 'cltbld', 09:33:24 INFO - 'MAIL': '/var/mail/cltbld', 09:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:24 INFO - 'MOZ_NO_REMOTE': '1', 09:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:24 INFO - 'NO_EM_RESTART': '1', 09:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:24 INFO - 'PWD': '/builds/slave/test', 09:33:24 INFO - 'SHELL': '/bin/bash', 09:33:24 INFO - 'SHLVL': '1', 09:33:24 INFO - 'TERM': 'linux', 09:33:24 INFO - 'TMOUT': '86400', 09:33:24 INFO - 'USER': 'cltbld', 09:33:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:24 INFO - '_': '/tools/buildbot/bin/python'} 09:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:24 INFO - Running setup.py (path:/tmp/pip-ZTqULZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:24 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)) 09:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:24 INFO - Running setup.py (path:/tmp/pip-pDo1OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:25 INFO - Running setup.py (path:/tmp/pip-5ggmcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:25 INFO - Running setup.py (path:/tmp/pip-ssFdeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:25 INFO - Running setup.py (path:/tmp/pip-f52qNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:25 INFO - Running setup.py (path:/tmp/pip-BOioT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:25 INFO - Running setup.py (path:/tmp/pip-2v62EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:25 INFO - Running setup.py (path:/tmp/pip-_0ZZgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:25 INFO - Running setup.py (path:/tmp/pip-pG7dX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:25 INFO - Running setup.py (path:/tmp/pip-jRCoUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:25 INFO - Running setup.py (path:/tmp/pip-Ir7rNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:25 INFO - Running setup.py (path:/tmp/pip-z1N3Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:25 INFO - Running setup.py (path:/tmp/pip-cfZTUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:25 INFO - Running setup.py (path:/tmp/pip-lBabzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:25 INFO - Running setup.py (path:/tmp/pip-4kp_ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:25 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)) 09:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:26 INFO - Running setup.py (path:/tmp/pip-EeiKaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:26 INFO - Running setup.py (path:/tmp/pip-cB8J_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:26 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)) 09:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:26 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)) 09:33:26 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)) 09:33:26 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)) 09:33:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:26 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 09:33:26 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 09:33:26 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 09:33:26 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 09:33:26 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 09:33:26 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 09:33:28 INFO - Downloading blessings-1.6.tar.gz 09:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:28 INFO - Installing collected packages: blessings 09:33:28 INFO - Running setup.py install for blessings 09:33:28 INFO - Successfully installed blessings 09:33:28 INFO - Cleaning up... 09:33:28 INFO - Return code: 0 09:33:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:28 INFO - Reading from file tmpfile_stdout 09:33:28 INFO - Current package versions: 09:33:28 INFO - argparse == 1.2.1 09:33:28 INFO - blessings == 1.6 09:33:28 INFO - blobuploader == 1.2.4 09:33:28 INFO - docopt == 0.6.1 09:33:28 INFO - functools32 == 3.2.3-2 09:33:28 INFO - jsonschema == 2.5.1 09:33:28 INFO - manifestparser == 1.1 09:33:28 INFO - mozInstall == 1.12 09:33:28 INFO - mozcrash == 1.0 09:33:28 INFO - mozdebug == 0.1 09:33:28 INFO - mozdevice == 0.48 09:33:28 INFO - mozfile == 1.2 09:33:28 INFO - mozhttpd == 0.7 09:33:28 INFO - mozinfo == 0.9 09:33:28 INFO - mozleak == 0.1 09:33:28 INFO - mozlog == 3.4 09:33:28 INFO - moznetwork == 0.27 09:33:28 INFO - mozprocess == 0.23 09:33:28 INFO - mozprofile == 0.28 09:33:28 INFO - mozrunner == 6.13 09:33:28 INFO - mozscreenshot == 0.1 09:33:28 INFO - mozsystemmonitor == 0.3 09:33:28 INFO - moztest == 0.8 09:33:28 INFO - mozversion == 1.4 09:33:28 INFO - psutil == 3.1.1 09:33:28 INFO - requests == 1.2.3 09:33:28 INFO - wsgiref == 0.1.2 09:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:28 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')]} 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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')]} 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:28 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 09:33:28 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 09:33:28 INFO - Using env: {'DISPLAY': ':0', 09:33:28 INFO - 'HOME': '/home/cltbld', 09:33:28 INFO - 'LANG': 'en_US.UTF-8', 09:33:28 INFO - 'LANGUAGE': 'en_US:en', 09:33:28 INFO - 'LOGNAME': 'cltbld', 09:33:28 INFO - 'MAIL': '/var/mail/cltbld', 09:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:28 INFO - 'MOZ_NO_REMOTE': '1', 09:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:28 INFO - 'NO_EM_RESTART': '1', 09:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:28 INFO - 'PWD': '/builds/slave/test', 09:33:28 INFO - 'SHELL': '/bin/bash', 09:33:28 INFO - 'SHLVL': '1', 09:33:28 INFO - 'TERM': 'linux', 09:33:28 INFO - 'TMOUT': '86400', 09:33:28 INFO - 'USER': 'cltbld', 09:33:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:28 INFO - '_': '/tools/buildbot/bin/python'} 09:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 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)) 09:33:28 INFO - Cleaning up... 09:33:28 INFO - Return code: 0 09:33:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:28 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')]} 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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')]} 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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 0x7fe7d6ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', '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 09:33:28 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 09:33:28 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 09:33:28 INFO - Using env: {'DISPLAY': ':0', 09:33:28 INFO - 'HOME': '/home/cltbld', 09:33:28 INFO - 'LANG': 'en_US.UTF-8', 09:33:28 INFO - 'LANGUAGE': 'en_US:en', 09:33:28 INFO - 'LOGNAME': 'cltbld', 09:33:28 INFO - 'MAIL': '/var/mail/cltbld', 09:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:28 INFO - 'MOZ_NO_REMOTE': '1', 09:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:28 INFO - 'NO_EM_RESTART': '1', 09:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:28 INFO - 'PWD': '/builds/slave/test', 09:33:28 INFO - 'SHELL': '/bin/bash', 09:33:28 INFO - 'SHLVL': '1', 09:33:28 INFO - 'TERM': 'linux', 09:33:28 INFO - 'TMOUT': '86400', 09:33:28 INFO - 'USER': 'cltbld', 09:33:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:28 INFO - '_': '/tools/buildbot/bin/python'} 09:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:29 INFO - Cleaning up... 09:33:29 INFO - Return code: 0 09:33:29 INFO - Running post-action listener: _resource_record_post_action 09:33:29 INFO - Running post-action listener: _start_resource_monitoring 09:33:29 INFO - Starting resource monitoring. 09:33:29 INFO - [mozharness: 2017-02-06 17:33:29.074308Z] Finished create-virtualenv step (success) 09:33:29 INFO - [mozharness: 2017-02-06 17:33:29.074772Z] Running install step. 09:33:29 INFO - Running pre-action listener: _resource_record_pre_action 09:33:29 INFO - Running main action method: install 09:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:29 INFO - Reading from file tmpfile_stdout 09:33:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:29 INFO - Reading from file tmpfile_stdout 09:33:29 INFO - Output received: 09:33:29 INFO - Usage: mozinstall [options] installer 09:33:29 INFO - Options: 09:33:29 INFO - -h, --help show this help message and exit 09:33:29 INFO - -d DEST, --destination=DEST 09:33:29 INFO - Directory to install application into. [default: 09:33:29 INFO - "/builds/slave/test"] 09:33:29 INFO - --app=APP Application being installed. [default: firefox] 09:33:29 INFO - mkdir: /builds/slave/test/build/application 09:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:33:43 INFO - Reading from file tmpfile_stdout 09:33:43 INFO - Output received: 09:33:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:43 INFO - Running post-action listener: _resource_record_post_action 09:33:43 INFO - [mozharness: 2017-02-06 17:33:43.508657Z] Finished install step (success) 09:33:43 INFO - [mozharness: 2017-02-06 17:33:43.508901Z] Running run-tests step. 09:33:43 INFO - Running pre-action listener: _resource_record_pre_action 09:33:43 INFO - Running main action method: run_tests 09:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:43 INFO - Python 2.7.3 09:33:43 INFO - Return code: 0 09:33:43 INFO - grabbing minidump binary from tooltool 09:33:43 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')]} 09:33:43 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 0x2b55f60>, '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 0x2b56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b571d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:43 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 09:33:43 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 09:33:43 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 09:33:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:43 INFO - Return code: 0 09:33:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:33:43 INFO - Using env: {'DISPLAY': ':0', 09:33:43 INFO - 'HOME': '/home/cltbld', 09:33:43 INFO - 'LANG': 'en_US.UTF-8', 09:33:43 INFO - 'LANGUAGE': 'en_US:en', 09:33:43 INFO - 'LOGNAME': 'cltbld', 09:33:43 INFO - 'MAIL': '/var/mail/cltbld', 09:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:43 INFO - 'MOZ_NO_REMOTE': '1', 09:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:43 INFO - 'NO_EM_RESTART': '1', 09:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:43 INFO - 'PWD': '/builds/slave/test', 09:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:43 INFO - 'SHELL': '/bin/bash', 09:33:43 INFO - 'SHLVL': '1', 09:33:43 INFO - 'TERM': 'linux', 09:33:43 INFO - 'TMOUT': '86400', 09:33:43 INFO - 'USER': 'cltbld', 09:33:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960', 09:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:43 INFO - '_': '/tools/buildbot/bin/python'} 09:33:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:33:43 INFO - mozversion application_buildid: 20170206072151 09:33:43 INFO - mozversion application_changeset: 9a1b79873db7526a0c9f33511e224a617af7ca6b 09:33:43 INFO - mozversion application_display_name: Firefox 09:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:43 INFO - mozversion application_name: Firefox 09:33:43 INFO - mozversion application_remotingname: firefox 09:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:33:43 INFO - mozversion application_vendor: Mozilla 09:33:43 INFO - mozversion application_version: 52.0 09:33:43 INFO - mozversion platform_buildid: 20170206072151 09:33:43 INFO - mozversion platform_changeset: 9a1b79873db7526a0c9f33511e224a617af7ca6b 09:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:33:43 INFO - mozversion platform_version: 52.0 09:33:43 INFO - using testdate: 1486402423 09:33:43 INFO - actual date: 1486402423 09:33:43 INFO - starting webserver on 'localhost:38131' 09:33:43 INFO - SUITE-START | Running 2 tests 09:33:43 INFO - TEST-START | dromaeo_css 09:33:43 INFO - operating with platform_type : linux_ 09:33:43 INFO - Initialising browser for dromaeo_css test... 09:33:43 INFO - TEST-INFO | started process 15330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl2TQZQ/profile http://localhost:38131/getInfo.html) 09:33:47 INFO - PROCESS | 15330 | __metrics Screen width/height:1600/1200 09:33:47 INFO - PROCESS | 15330 | colorDepth:24 09:33:47 INFO - PROCESS | 15330 | Browser inner width/height: 1024/697 09:33:47 INFO - PROCESS | 15330 | __metrics 09:33:48 INFO - PROCESS | 15330 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:48 INFO - PROCESS | 15330 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:48 INFO - PROCESS | 15330 | console.error: PushService: 09:33:48 INFO - PROCESS | 15330 | stateChangeProcessEnqueue: Error transitioning state 09:33:48 INFO - PROCESS | 15330 | UnknownError 09:33:49 INFO - TEST-INFO | 15330: exit 0 09:33:49 INFO - Browser initialized. 09:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:49 INFO - TEST-INFO | started process 15422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl2TQZQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:01 INFO - PROCESS | 15422 | RSS: Main: 142004224 09:34:01 INFO - PROCESS | 15422 | 09:37:02 INFO - PROCESS | 15422 | Cycle 1(1): loaded http://localhost:38131/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38131/tests/dromaeo/cssquery-ext.html) 09:37:03 INFO - PROCESS | 15422 | RSS: Main: 235110400 09:37:03 INFO - PROCESS | 15422 | 09:40:06 INFO - PROCESS | 15422 | Cycle 1(1): loaded http://localhost:38131/tests/dromaeo/cssquery-ext.html (next: http://localhost:38131/tests/dromaeo/cssquery-jquery.html) 09:40:06 INFO - PROCESS | 15422 | RSS: Main: 225673216 09:40:06 INFO - PROCESS | 15422 | 09:43:08 INFO - PROCESS | 15422 | Cycle 1(1): loaded http://localhost:38131/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38131/tests/dromaeo/cssquery-mootools.html) 09:43:09 INFO - PROCESS | 15422 | RSS: Main: 215777280 09:43:09 INFO - PROCESS | 15422 | 09:46:11 INFO - PROCESS | 15422 | Cycle 1(1): loaded http://localhost:38131/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38131/tests/dromaeo/cssquery-prototype.html) 09:46:11 INFO - PROCESS | 15422 | RSS: Main: 221278208 09:46:11 INFO - PROCESS | 15422 | 09:49:14 INFO - PROCESS | 15422 | Cycle 1(1): loaded http://localhost:38131/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38131/tests/dromaeo/cssquery-yui.html) 09:49:14 INFO - PROCESS | 15422 | RSS: Main: 174579712 09:49:14 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | Cycle 1(1): loaded http://localhost:38131/tests/dromaeo/cssquery-yui.html (next: http://localhost:38131/tests/dromaeo/cssquery-dojo.html) 09:52:17 INFO - PROCESS | 15422 | RSS: Main: 266059776 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | __start_tp_report 09:52:17 INFO - PROCESS | 15422 | _x_x_mozilla_page_load 09:52:17 INFO - PROCESS | 15422 | _x_x_mozilla_page_load_details 09:52:17 INFO - PROCESS | 15422 | |i|pagename|runs| 09:52:17 INFO - PROCESS | 15422 | |0;dojo.html;3245.5293982372555;3273.214428537152;3277.229850985018;3300.2739397332607;3325.0689806854075;5477;5538.307711536058;5544.473275038875;5548.55611551076;5561.221428999943;5530.391656917746;5539;5584.972075139629;5585.832425027245;5604.635698679583;5017.7240251786225;5038.5969122470115;5074.3657042869645;5106.744662766865;5115.309433226504;4896.338994235786;4924.753762311888;5066.594672426216;5116.513931176551;5123.359580052494;5009.148444764381;5031.044101620699;5040.294358789773;5052.166392545226;5056.974715126419;5068.619853510983;5086.21163719624;5143.434222235588;5150.330457040561;5173.637845350827;4801.567858892717;5036.823711170128;5058.671186372911;5096.9490305097215;5124.205748109011;5361;5428.294321738149;5437.782488700447;5440.347158340985;5499.340079190522;5839.328477225131;5846.9707651461895;5963.19496867926;5968.283805943272;5971.134185543072;5779.450952159538;5985.25184351956;6003.789867354665;6013.128096426038;6022.126791615191;5405.000074986101;5549.6115271930985;5556.99974004679;5576.470235327637;5664.235328230636;6041.516678665696;6048.818535443944;6061.030235162353;6069.393060693896;6118.449339559461;5586.972065139648;5883.0881213411985;5883.499902508249;5889.057750759858;5892.175095486636;5671.773129074791;5868.501177399969;5873.4126587340925;5889.322727886262;6006.399360064046;5929.199558059693;5931.08068249422;5934.851628709317;5938.406159384027;5940.6435613863305;5886.941130588725;5945.970270148621;5946.583739138218;5953.434423729739;5970.611910225822;4477.059817438309;4511.8646440606835;4571.3600095986585;4574.382458368144;4576.931346029813;4079.9592004080173;4098.467199264136;4104.794760262034;4127.29835927887;4138.958610413918;5598.216249725042;5611.130274807411;5614;5615.926712454827;5651.2935883014625;5746.913796293059;5791.420857914175;5825.679587622722;5835.854103647358;5920.615160014671;5538.030844602178;5585.944140558624;5600.859978500489;5606.131049687305;5608.85977850557;5023.09584274834;5030.156034444156;5032.496750324938;5036.546710795973;5076.898462030813;5971.43271389226;6001.339852616296;6068.787592434332;6137.079438084323;6155.199824022849;5804.071348584206;5856.94143058564;5922.200502932049;5943.881122377615;5988.191594134911;6184.907226391518;6209.720562574605;6216.689165541615;6217.067439884054;6222.782202622887;5752.7082555099;5852.092925596539;5860.208871802252;5870.530357571299;5886.735096920564;5763.7118144093465;5833.854153646193;5854.677992710442;5875.823725288077;5895.20414744004;5751;5800.56495762811;5817.767289308549;5823.941760582509;5827.067669173081;5763.366029736641;5797.101449275369;5798.536117110705;5798.623089499169;5798.623089499169;5566.721663916869;5629.240052592848;5680.062789639828;5692.800751973661;5776.595638305278;5886.470217680429;5886.646801191942;5894.115882617471;5908.261467316585;5919.171316015675;5532.861678458071;5550.4449555044175;5737.053386191232;5745.942540574708;5747.913781293368 09:52:17 INFO - PROCESS | 15422 | |1;ext.html;590.3742033444549;601.2184160591231;633.6736580660959;644.3749562923962;655.977040803572;33057;33534;44923.77538112313;45941.770291148496;46193.538064619344;42207.36688949668;46398.30402543965;46466;46507.30239046417;46615.53384466154;8801.119888011212;8918.73243802687;8930.330225233101;8964.596593153292;8970.641174353019;8156;8406.621702023423;10572.947135264312;10757.83863242052;10773.299735517205;10863.402512861789;10919;10920.836187457155;10941.671749847477;10946.616868409606;10663.413512256822;10686.51910664022;10694.144468442584;10708.946455267713;10720;10691.679249622524;10750.516226769814;10757.569697212102;10766.24636275461;10774.838377424345;43488.56511434877;43549.564504355185;43758.34362484565;43796.78101609503;43932;3615.692666123383;3630.455431685242;3731.9626803731885;3825;4045.4134150548007;32335.676643233503;32395.51406728901;32745.181370465692;32837;32866.6713332866;4139.172165566869;4172.749635021908;4462.576055274776;4490.932636010462;4502.16709908668;346839.9999999975;347499;347742;350001;351424;61974.69012654908;62352.688236558526;62465.687671561354;62567.6871615639;62985;39238.803805981355;39732.801335993136;39893.800530997156;42549;68096.319036809;18955.241790328233;19106.71339929902;19133.904330478257;19138.043097845053;19140.23439062422;11727.179097463095;11832.76334473323;14765.187914664582;14875.404983800743;14883.627909302355;19749.308774192836;20156.69764953527;20202.898985504977;21238;21256.36230913075;7255.963720181366;7392.556446613113;7574.583397913168;7577.848443031108;7623.69505219785;935.9204467620328;1031.4481752262504;1031.9535620897077;1048.3238311289329;1076.7200527862656;33004.1748956278;33135;33141.66858331386;33156.33687326288;33223.777440767815;1087.505185140759;1099.230538622967;1131.728385187549;1157.780021795856;1226.1600803449664;14944.252787360589;17593.20830562602;17962.820371796377;18818.623627527373;19584.804151958582;524954;526577;529113;532020;533574;60229.698851506335;60610.09084863731;60694.69652651709;60695.69652151711;60699;1256.849178098634;1301.264785396248;1331.8601546837442;1342.89256859451;1346.7979803029427;29867.253318667208;32651.34697306088;33917.15207119842;33992.66007339895;34484.31031379308;50900.490995089574;51400.74299628478;51533.227001595755;51551;51564.48435515597;300024;301423;302221;302339;302878;26516.337091572866;27500.449990999667;29554.556681649363;29705.405891882474;29922;48790.53622449255;49323.50676493189;49425;49427.258591120444;50136.74931625318;40819.38770918498;40868.386974194815;41014.589854101076;42036;44682.77658611686;41450.585494144674;41640.16719665529;41968.79015605024;42459.15081698287;43290;40367.39448908327;41811.7909410451;42071.57928420799;44226.778866105466;44475.11049778922;34680.479792802624;38319;38334.80832595819;38574.80712596419;39134.6086539131;28162.2959426016;28223;28350.432991339647;28352;28359.57460638051 09:52:17 INFO - PROCESS | 15422 | |2;jquery.html;402.5793046266652;402.7120608764733;409.50245451776084;414.67240879705037;428.55858465780256;14461.493847715332;18483.907580462113;19486.415407537796;20218.19127234909;20229.898850505746;15066.698666026672;16686;19448.513787155327;19460.70808937867;20027.899860500715;5787.971060144693;5958.821235362924;5982.461578457938;5985.88028239435;5985.940140598604;5678;5769.365369809318;5888.676122813244;5891.941080589204;5931.970340148293;5758.021136406821;5759.452851979056;5760.308762948452;5765.279340082489;5766.567507436938;5604.2714447122025;5751.712414379285;5754.827355179351;5825.1844741736195;5878.50032747217;5258.894822103536;5265.183896496049;5265.552428043621;5271.130263506555;5272.393674727417;23090.65364019541;23394.64908026381;23497.17759878396;24062.759372406403;24544.631830522558;2742.162234663521;2762.4337010912714;3146.669599692022;3164.1931307516666;3208.4224839528874;14920;15120.319585618674;15308.234588270541;15329.156896370696;15337.846621533754;1934;1967.7245185674017;1983.1373352591525;1994.7706013808452;2064.989675051615;81623;81651;82972;83063.5846820768;83234;10670.51982660782;10695.73260668474;10994.945025274823;11083.891660025853;11135.33188008722;15732.05607663544;15750.606234843992;15750.9212453937;15776;15960.36158553668;7420.5547667140145;7749.690012399441;8377.916220837713;8408.831823363498;8827.867581986147;8544.273736732323;8690.174433428814;8767.21095101444;8978.371513993958;9077.133495360633;6833.624150671761;6839.863202735917;6840.589564626139;6863.588184708933;6901.275366086589;1944;1969.8030196980187;1995.5897466598979;2007.1670256843247;2054.3220737156703;905.6694306578052;997.2670087485692;1013.7364285285731;1032.9690109296732;1046.5865982936698;19365;19489.512762180777;20086.266732771444;20119;20537.794622053887;991.3159919655415;1000.3347773730533;1008.566316483919;1025.2925481417947;1053.9736506587396;9432.245420366355;11432.599859004895;11577.098560574848;11614.419279036014;11638.41807909601;507883;521103;524913;549236;551545;83343.333133337;86107;87233.56383218043;87835;89152.55423722969;1051.4112097225577;1052.5474046160225;1067.6316670748733;1073.2433634287809;1112.4938153140301;18166.27334906589;18188.454346369632;18280.268789248814;18443.538911527317;18714.532136696147;40213.59786402099;40334.1933161341;40494;40983.59016409798;42051.1589768209;53517.732411337696;54212.45787542074;54317.45682543282;63334;63844;7834.412419068707;8370.149253731342;8393.916060839558;8429.957850210709;8726.781830454289;11527.8270825936;11552.249103808226;11682.76634467323;12523.812142817682;12823.166494177849;10752.40861752611;10965.835512467478;11411.60059397917;11510.82733759011;11512.30926144434;11405;11842.703932401759;11919.284842909454;12170.087243456599;12178.45196966121;11270.380129092979;11455.198136130724;11514.36670983104;11633.825492617449;11801.468933898166;8416.242538171595;8433.451825631315;8451.070382257823;8520.573971301534;8635.6977505787;9138.817223655356;11108.88891111111;11165.665030049111;11346.94326528362;11427.314361138358 09:52:17 INFO - PROCESS | 15422 | |3;mootools.html;1176.9470373833176;1430.964225894353;1468.2145052396966;1566.6553358261185;1722.1303241862865;7426.368758655514;8451.577421128943;8669.393142480028;8706.172913573208;8932.910670893289;8863.689770858022;8904.421212621175;8924.59839307231;8925.821483570324;8928.062553431893;2472.0976843452145;2507.7492250774867;2510.686164229471;2512.5351809915223;2514.094925826701;2429.0526694589034;2478.615814548739;2478.8140889433275;2479.528889510987;2482.2305085423577;2469.740677228892;2480.1815400917653;2502.4995000999784;2505.649209110726;2506.2982364937848;2386.248331775485;2401.903923843044;2417.190241269177;2419.806415486757;2423.915162969305;2389.749076346976;2399.124319623342;2412.433078226615;2415.625578035407;2432.2460037388464;8523.318134549221;8602.612882420306;8741.956290218508;8750.518721470316;8785.956070219672;5246.711430871301;5454.563634909237;5464.508194262496;5473.042217611942;5483.972580137074;3426.126337783874;3530.4880792284976;3571.749977501576;3584.229390681016;3604.567451905762;1038.9480525973747;1062.3413483640115;1074.9516271767789;1100.5267734874;1109.1459576126338;11797.174197806156;11798.941005295004;11862.52549898003;11863.822042669453;11874.703132421671;4460.8661740147845;4678;4754.952450475451;4760.738159401266;4785.880352991134;9558.330916835894;9598.184154346958;9601.663941762004;9629.374090684083;9665.806683866424;5457.045017122067;5462.071447853875;5468.617196796186;5476.205950137208;5481.314835645544;4308.9569104309185;4475.306327519174;4642.373279607277;5105.336306280234;5128.435872054071;3925.980370098131;3957.821898014596;4053.473048503735;4055.371417430303;4062.3500239961463;1198.26306821306;1244.0669497876593;1246.8690787467367;1249.2005116725122;1258.452573130691;978.7944531648291;985.6500942165571;994.8507723841337;996.4320337407609;1000.7548150703125;6039.7282122304605;6219.440250377397;6228.4705800007505;6346.809595712136;6408.00675895237;480.61550759392344;492.5419359995239;494.30303272385765;494.35486689869344;504.88892443662337;4138.606832350922;4152.003519155442;4187.958120418757;4200.915981680349;4203.558626344251;10534;11038.944805275922;11040.33757974524;11043.33739975588;11045.83431248532;10890.61882834097;10977.451127443595;10977.451127443595;10995.450227488594;10996.0653344465;7815.726449574237;8166.469179503313;8188.50868947865;8391.035030971394;8416;6081.239845019372;6166.167567378347;6245.531585131224;6250.249970003629;6269.467095296951;9825.557849896915;9980.201583873419;10008.14930730896;10036.447995360033;10149;8689.435186712843;9942.701718948443;10062.647807326708;10095.697129086138;10186.185105191418;7376.96311518439;7435.553866768011;7535.8492830141995;7565.962170189114;7577.128630207376;7883.487573307717;7896.605169741375;7929.484583502054;7929.960350198212;7933.404994625542;7184.676689548878;7367.668454919649;7373.483856130019;7423.703051877865;7513.323800857949;7189.604571748395;7280.781576552712;7295.854082918206;7313.049303590499;7377.4835761498325;6917.27368626287;6996.930030699627;7049.118860142482;7067.717291308496;7127.251638578082;5187.661026390974;5291.3385826771655;5317.533272051495;5398.325209348832;5521;5304.787808487617;5313.760880760297;5328.254044433705;5409.1886217066185;5448.019356515865 09:52:17 INFO - PROCESS | 15422 | |4;prototype.html;337.7770671356905;343.91745980964566;349.96325385834496;351.43068229468236;359.0431500052359;5248.239005344228;5312.203169524573;5313.468653134684;5326.493983071602;5343.65266257693;5193.246979188016;5206.3231779868565;5217.765200565974;5231.764570594323;5273.736313184345;3974.3839704845795;4213;4218.789060546976;4248.235317642823;4250.319948808191;4056.290149223889;4082.326416141333;4152;4186.267403204442;4187.016051227959;4114.547399786036;4138.813753381105;4141.979290103561;4151.149014452045;4157.355609880473;4142.896427589304;4146.398772178048;4160.2303573838935;4169.687273454473;4176.310908700061;3496.7727097738566;3505.2989402119424;3681.226942342111;3702.018964974284;3719.7210209234418;5119.513646203642;5122.231665250205;5124.718140502271;5127.410347809975;5145.33110695611;4739.668223224376;4758.025419450923;4765.26138448541;4770.546798054179;4772.976135119302;5400.460868652415;5502.413865483217;5505.6696598204235;5517.9443109314625;5529;4101.323281658522;4104.281750693646;4107.322291821846;4110.047727329525;4111.629953304187;5693;5703.233931543198;5711.971440142815;5712.685802280873;5723.284589426322;4029.174019326031;4202.159568086395;4223.746575205498;4231.196072746168;4237.745735255895;4259.339802330644;4262.680298977589;4266.509351424564;4284.742915425085;4298.3552467130185;4773.403324584427;4791.832285869978;4797.712137271775;4798.568128868349;4800.831970881002;5352.892942141136;5519.31008623922;5560.638558493685;5563.13771365439;5563.972180139154;1429.2353590828857;1434.7202295552477;1438.9711356380237;1442.2572375226766;1445.3279225160352;969.9709008729608;1017.3793985668736;1024.764304210021;1027.1320733979776;1030.2788048366174;5110.71891045996;5168.819091331786;5169.638125331191;5178.741062946838;5204.8178313758835;5487.835364938978;5566.499015088581;5628.324601047901;5641.9435805641415;5669.6314739541795;5357.464253574689;5372.328458942632;5385.380681221632;5389.865253368697;5390.434004429479;2805.7474827265237;2896.942061158807;2898.449294634055;2899.7535209507428;2920.269932516871;5719.656820590778;5719.914201286984;5736.942630573724;5741.483266506035;5743.913841292384;5620.634658747168;5628.71856407178;5633.887322253532;5635.605507614428;5639.943600563942;5455.372632147274;5687.829365119053;5714.828555143353;5741.799037033684;5768.855778605568;5400.864978375572;5419.05166595852;5433.673979561239;5468.589855760913;5471.562275018068;5198.532132108128;5442.23808666779;5447.700376479332;5450.874159077884;5452.400235974119;5632.324121105494;5705.486506214461;5709.9714501427225;5711.657300561979;5750.856228594152;4125.793710314532;4128.793560321912;4130.05887233;4155.5013398391175;4156.272652285898;5282.234076058873;5385.892282154413;5505.119180931032;5508.256385387921;5517.310336207974;5365.892682146413;5377.2740680009265;5412.350517937715;5428.83713488596;5463.535599474089;5297.973510132425;5376.704281264568;5387.892242155213;5407.918416316674;5433.510984011458;5080.568151707146;5325.813596524103;5357.678539287655;5374.355077390738;5381.838544843661;5363.517283444508;5379.704116273642;5399.759099973624;5400.459954004568;5416;5302.496262855023;5357.410684824588;5461.235427040138;5465.152901300305;5478.45215478449 09:52:17 INFO - PROCESS | 15422 | |5;yui.html;700.8703389872873;721.747388414055;733.2557454184001;754.2758951406649;805.7864665863543;14476.565703028913;15102.471413500529;15125.16811575363;15132.167730774803;15181.39274429023;13711.65720856979;14047.36786844592;14070.859291407083;14083;14121.223332716696;697.9930200697979;721.0410154494535;782.0927723840347;791.3669064748207;834.1075049696827;851.4082712514804;854.7948492361851;855.1533981358441;856.0882659967147;856.4604299291437;883.7525492862009;885.8848349714528;886.0342226972599;888.1606881496988;888.4225253585157;873.5195642396689;875.4222213339166;875.6322344615277;878.6792820620492;878.9077146899548;648.4488185042676;650.4146268358515;651.2022772104182;651.9315471875432;654.5516321319864;13453.327333633377;13678.042537022413;13715.245661488614;13737.519186828513;15061.096334219981;14755.483558075523;15216.467423640119;15328.693426131415;15454.61363465911;15483.845161548354;11465.254758440758;11492.770144597145;11656.125790565742;11747.47136378865;12071.215371000944;4446.599806017474;4505.504394516601;4506.324051392285;4513.638908887281;4529.660275479352;65246.673766631335;65319.3468065318;65586.34413655898;66287;68552.65723671399;10462.947685261524;10721;10776.137908967265;11073.612423565137;11077.11383089351;19184.424467266006;19366.70949935752;19395.127219274884;19417.80582194188;19444.319448819508;8209.09699933007;8232;8586.828263434822;8616.48301101936;9032.503212323385;4758.619310455155;4850.708957462493;4890.853274401774;4907.190313598217;4961.925571116436;3477.808720520345;3554.662307080875;3562.87529936451;3571.089372210122;3613.6928361089076;635.1203583037434;647.0423772816164;662.5395350231543;668.6890595872942;669.1902797614844;750.8761054426068;765.8430021845509;775.918528554505;790.4624855098588;798.4211446701095;8945.552722363856;9184.72445826613;9369.205471783938;9490.762730931781;9519;634.3022675057492;645.5868244323636;747.4468893019235;748.4910261022449;752.8193233623891;4704.341392205094;4922.72924989129;4952.727599982036;4968.130577148984;4975.278584605285;71895;72245.63877180581;74012.25987740053;87588.56205718931;90188;70491.2950870495;72809;74023.62988185132;74480.25519744733;75445.62277188578;66360.33639663638;67023.66488167529;67134.32865671281;68480;69379.65310173416;9736.221102311656;9927.40435573868;10003.292525966162;10080.94959525227;10087.848682269918;46998;47903.76048119737;48210.758946205046;48629.75685121552;48857.5114248853;37769.433458498694;53063;61380.772384552954;62441.687791560755;63510.68244658932;12723.80914286268;12963.935180324039;12966.092373533762;13350.399232034775;13443.126196797177;13971.441142354191;14822.332995015035;14823.629409264855;14945.701085978002;15020.399184032953;13756.76189142982;13878.236696981763;14009.299535023412;14157.43370265219;14651.560453186421;13368.866311336762;13425.194488330731;13447.731045379232;13858.86141138616;14208.147511149364;13106.868931310946;13154.473821047433;13157.736845262849;13212.339383030618;13312.933435332761;10947;11284.887151128713;11599.188056835941;11662.591809286634;12018.158728888893;12313.630591082281;12527.37363131858;12542.49830006826;12638.115331926678;12653.557125500563 09:52:17 INFO - PROCESS | 15422 | __end_tp_report 09:52:17 INFO - PROCESS | 15422 | __start_cc_report 09:52:17 INFO - PROCESS | 15422 | _x_x_mozilla_cycle_collect,927 09:52:17 INFO - PROCESS | 15422 | __end_cc_report 09:52:17 INFO - PROCESS | 15422 | __startTimestamp1486403537492__endTimestamp 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | ------- Summary: start ------- 09:52:17 INFO - PROCESS | 15422 | Number of tests: 6 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | [#0] dojo.html Cycles:165 Average:5502.47 Median:5692.80 stddev:608.93 (10.7%) stddev-sans-first:584.49 09:52:17 INFO - PROCESS | 15422 | Values: 3245.5 3273.2 3277.2 3300.3 3325.1 5477.0 5538.3 5544.5 5548.6 5561.2 5530.4 5539.0 5585.0 5585.8 5604.6 5017.7 5038.6 5074.4 5106.7 5115.3 4896.3 4924.8 5066.6 5116.5 5123.4 5009.1 5031.0 5040.3 5052.2 5057.0 5068.6 5086.2 5143.4 5150.3 5173.6 4801.6 5036.8 5058.7 5096.9 5124.2 5361.0 5428.3 5437.8 5440.3 5499.3 5839.3 5847.0 5963.2 5968.3 5971.1 5779.5 5985.3 6003.8 6013.1 6022.1 5405.0 5549.6 5557.0 5576.5 5664.2 6041.5 6048.8 6061.0 6069.4 6118.4 5587.0 5883.1 5883.5 5889.1 5892.2 5671.8 5868.5 5873.4 5889.3 6006.4 5929.2 5931.1 5934.9 5938.4 5940.6 5886.9 5946.0 5946.6 5953.4 5970.6 4477.1 4511.9 4571.4 4574.4 4576.9 4080.0 4098.5 4104.8 4127.3 4139.0 5598.2 5611.1 5614.0 5615.9 5651.3 5746.9 5791.4 5825.7 5835.9 5920.6 5538.0 5585.9 5600.9 5606.1 5608.9 5023.1 5030.2 5032.5 5036.5 5076.9 5971.4 6001.3 6068.8 6137.1 6155.2 5804.1 5856.9 5922.2 5943.9 5988.2 6184.9 6209.7 6216.7 6217.1 6222.8 5752.7 5852.1 5860.2 5870.5 5886.7 5763.7 5833.9 5854.7 5875.8 5895.2 5751.0 5800.6 5817.8 5823.9 5827.1 5763.4 5797.1 5798.5 5798.6 5798.6 5566.7 5629.2 5680.1 5692.8 5776.6 5886.5 5886.6 5894.1 5908.3 5919.2 5532.9 5550.4 5737.1 5745.9 5747.9 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | [#1] ext.html Cycles:180 Average:56706.44 Median:3623.07 stddev:107168.61 (2957.9%) stddev-sans-first:107386.42 09:52:17 INFO - PROCESS | 15422 | Values: 590.4 601.2 633.7 644.4 656.0 33057.0 33534.0 44923.8 45941.8 46193.5 42207.4 46398.3 46466.0 46507.3 46615.5 8801.1 8918.7 8930.3 8964.6 8970.6 8156.0 8406.6 10572.9 10757.8 10773.3 10863.4 10919.0 10920.8 10941.7 10946.6 10663.4 10686.5 10694.1 10708.9 10720.0 10691.7 10750.5 10757.6 10766.2 10774.8 43488.6 43549.6 43758.3 43796.8 43932.0 3615.7 3630.5 3732.0 3825.0 4045.4 32335.7 32395.5 32745.2 32837.0 32866.7 4139.2 4172.7 4462.6 4490.9 4502.2 346840.0 347499.0 347742.0 350001.0 351424.0 61974.7 62352.7 62465.7 62567.7 62985.0 39238.8 39732.8 39893.8 42549.0 68096.3 18955.2 19106.7 19133.9 19138.0 19140.2 11727.2 11832.8 14765.2 14875.4 14883.6 19749.3 20156.7 20202.9 21238.0 21256.4 7256.0 7392.6 7574.6 7577.8 7623.7 935.9 1031.4 1032.0 1048.3 1076.7 33004.2 33135.0 33141.7 33156.3 33223.8 1087.5 1099.2 1131.7 1157.8 1226.2 14944.3 17593.2 17962.8 18818.6 19584.8 524954.0 526577.0 529113.0 532020.0 533574.0 60229.7 60610.1 60694.7 60695.7 60699.0 1256.8 1301.3 1331.9 1342.9 1346.8 29867.3 32651.3 33917.2 33992.7 34484.3 50900.5 51400.7 51533.2 51551.0 51564.5 300024.0 301423.0 302221.0 302339.0 302878.0 26516.3 27500.4 29554.6 29705.4 29922.0 48790.5 49323.5 49425.0 49427.3 50136.7 40819.4 40868.4 41014.6 42036.0 44682.8 41450.6 41640.2 41968.8 42459.2 43290.0 40367.4 41811.8 42071.6 44226.8 44475.1 34680.5 38319.0 38334.8 38574.8 39134.6 28162.3 28223.0 28350.4 28352.0 28359.6 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | [#2] jquery.html Cycles:180 Average:30217.95 Median:2752.30 stddev:87254.84 (3170.3%) stddev-sans-first:87470.89 09:52:17 INFO - PROCESS | 15422 | Values: 402.6 402.7 409.5 414.7 428.6 14461.5 18483.9 19486.4 20218.2 20229.9 15066.7 16686.0 19448.5 19460.7 20027.9 5788.0 5958.8 5982.5 5985.9 5985.9 5678.0 5769.4 5888.7 5891.9 5932.0 5758.0 5759.5 5760.3 5765.3 5766.6 5604.3 5751.7 5754.8 5825.2 5878.5 5258.9 5265.2 5265.6 5271.1 5272.4 23090.7 23394.6 23497.2 24062.8 24544.6 2742.2 2762.4 3146.7 3164.2 3208.4 14920.0 15120.3 15308.2 15329.2 15337.8 1934.0 1967.7 1983.1 1994.8 2065.0 81623.0 81651.0 82972.0 83063.6 83234.0 10670.5 10695.7 10994.9 11083.9 11135.3 15732.1 15750.6 15750.9 15776.0 15960.4 7420.6 7749.7 8377.9 8408.8 8827.9 8544.3 8690.2 8767.2 8978.4 9077.1 6833.6 6839.9 6840.6 6863.6 6901.3 1944.0 1969.8 1995.6 2007.2 2054.3 905.7 997.3 1013.7 1033.0 1046.6 19365.0 19489.5 20086.3 20119.0 20537.8 991.3 1000.3 1008.6 1025.3 1054.0 9432.2 11432.6 11577.1 11614.4 11638.4 507883.0 521103.0 524913.0 549236.0 551545.0 83343.3 86107.0 87233.6 87835.0 89152.6 1051.4 1052.5 1067.6 1073.2 1112.5 18166.3 18188.5 18280.3 18443.5 18714.5 40213.6 40334.2 40494.0 40983.6 42051.2 53517.7 54212.5 54317.5 63334.0 63844.0 7834.4 8370.1 8393.9 8430.0 8726.8 11527.8 11552.2 11682.8 12523.8 12823.2 10752.4 10965.8 11411.6 11510.8 11512.3 11405.0 11842.7 11919.3 12170.1 12178.5 11270.4 11455.2 11514.4 11633.8 11801.5 8416.2 8433.5 8451.1 8520.6 8635.7 9138.8 11108.9 11165.7 11346.9 11427.3 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | [#3] mootools.html Cycles:180 Average:5756.79 Median:5116.89 stddev:3198.05 (62.5%) stddev-sans-first:3188.49 09:52:17 INFO - PROCESS | 15422 | Values: 1176.9 1431.0 1468.2 1566.7 1722.1 7426.4 8451.6 8669.4 8706.2 8932.9 8863.7 8904.4 8924.6 8925.8 8928.1 2472.1 2507.7 2510.7 2512.5 2514.1 2429.1 2478.6 2478.8 2479.5 2482.2 2469.7 2480.2 2502.5 2505.6 2506.3 2386.2 2401.9 2417.2 2419.8 2423.9 2389.7 2399.1 2412.4 2415.6 2432.2 8523.3 8602.6 8742.0 8750.5 8786.0 5246.7 5454.6 5464.5 5473.0 5484.0 3426.1 3530.5 3571.7 3584.2 3604.6 1038.9 1062.3 1075.0 1100.5 1109.1 11797.2 11798.9 11862.5 11863.8 11874.7 4460.9 4678.0 4755.0 4760.7 4785.9 9558.3 9598.2 9601.7 9629.4 9665.8 5457.0 5462.1 5468.6 5476.2 5481.3 4309.0 4475.3 4642.4 5105.3 5128.4 3926.0 3957.8 4053.5 4055.4 4062.4 1198.3 1244.1 1246.9 1249.2 1258.5 978.8 985.7 994.9 996.4 1000.8 6039.7 6219.4 6228.5 6346.8 6408.0 480.6 492.5 494.3 494.4 504.9 4138.6 4152.0 4188.0 4200.9 4203.6 10534.0 11038.9 11040.3 11043.3 11045.8 10890.6 10977.5 10977.5 10995.5 10996.1 7815.7 8166.5 8188.5 8391.0 8416.0 6081.2 6166.2 6245.5 6250.2 6269.5 9825.6 9980.2 10008.1 10036.4 10149.0 8689.4 9942.7 10062.6 10095.7 10186.2 7377.0 7435.6 7535.8 7566.0 7577.1 7883.5 7896.6 7929.5 7930.0 7933.4 7184.7 7367.7 7373.5 7423.7 7513.3 7189.6 7280.8 7295.9 7313.0 7377.5 6917.3 6996.9 7049.1 7067.7 7127.3 5187.7 5291.3 5317.5 5398.3 5521.0 5304.8 5313.8 5328.3 5409.2 5448.0 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | [#4] prototype.html Cycles:180 Average:4628.11 Median:5260.99 stddev:1318.84 (25.1%) stddev-sans-first:1282.63 09:52:17 INFO - PROCESS | 15422 | Values: 337.8 343.9 350.0 351.4 359.0 5248.2 5312.2 5313.5 5326.5 5343.7 5193.2 5206.3 5217.8 5231.8 5273.7 3974.4 4213.0 4218.8 4248.2 4250.3 4056.3 4082.3 4152.0 4186.3 4187.0 4114.5 4138.8 4142.0 4151.1 4157.4 4142.9 4146.4 4160.2 4169.7 4176.3 3496.8 3505.3 3681.2 3702.0 3719.7 5119.5 5122.2 5124.7 5127.4 5145.3 4739.7 4758.0 4765.3 4770.5 4773.0 5400.5 5502.4 5505.7 5517.9 5529.0 4101.3 4104.3 4107.3 4110.0 4111.6 5693.0 5703.2 5712.0 5712.7 5723.3 4029.2 4202.2 4223.7 4231.2 4237.7 4259.3 4262.7 4266.5 4284.7 4298.4 4773.4 4791.8 4797.7 4798.6 4800.8 5352.9 5519.3 5560.6 5563.1 5564.0 1429.2 1434.7 1439.0 1442.3 1445.3 970.0 1017.4 1024.8 1027.1 1030.3 5110.7 5168.8 5169.6 5178.7 5204.8 5487.8 5566.5 5628.3 5641.9 5669.6 5357.5 5372.3 5385.4 5389.9 5390.4 2805.7 2896.9 2898.4 2899.8 2920.3 5719.7 5719.9 5736.9 5741.5 5743.9 5620.6 5628.7 5633.9 5635.6 5639.9 5455.4 5687.8 5714.8 5741.8 5768.9 5400.9 5419.1 5433.7 5468.6 5471.6 5198.5 5442.2 5447.7 5450.9 5452.4 5632.3 5705.5 5710.0 5711.7 5750.9 4125.8 4128.8 4130.1 4155.5 4156.3 5282.2 5385.9 5505.1 5508.3 5517.3 5365.9 5377.3 5412.4 5428.8 5463.5 5298.0 5376.7 5387.9 5407.9 5433.5 5080.6 5325.8 5357.7 5374.4 5381.8 5363.5 5379.7 5399.8 5400.5 5416.0 5302.5 5357.4 5461.2 5465.2 5478.5 09:52:17 INFO - PROCESS | 15422 | 09:52:17 INFO - PROCESS | 15422 | [#5] yui.html Cycles:180 Average:17657.24 Median:48743.63 stddev:22445.80 (46.0%) stddev-sans-first:22472.65 09:52:17 INFO - PROCESS | 15422 | Values: 700.9 721.7 733.3 754.3 805.8 14476.6 15102.5 15125.2 15132.2 15181.4 13711.7 14047.4 14070.9 14083.0 14121.2 698.0 721.0 782.1 791.4 834.1 851.4 854.8 855.2 856.1 856.5 883.8 885.9 886.0 888.2 888.4 873.5 875.4 875.6 878.7 878.9 648.4 650.4 651.2 651.9 654.6 13453.3 13678.0 13715.2 13737.5 15061.1 14755.5 15216.5 15328.7 15454.6 15483.8 11465.3 11492.8 11656.1 11747.5 12071.2 4446.6 4505.5 4506.3 4513.6 4529.7 65246.7 65319.3 65586.3 66287.0 68552.7 10462.9 10721.0 10776.1 11073.6 11077.1 19184.4 19366.7 19395.1 19417.8 19444.3 8209.1 8232.0 8586.8 8616.5 9032.5 4758.6 4850.7 4890.9 4907.2 4961.9 3477.8 3554.7 3562.9 3571.1 3613.7 635.1 647.0 662.5 668.7 669.2 750.9 765.8 775.9 790.5 798.4 8945.6 9184.7 9369.2 9490.8 9519.0 634.3 645.6 747.4 748.5 752.8 4704.3 4922.7 4952.7 4968.1 4975.3 71895.0 72245.6 74012.3 87588.6 90188.0 70491.3 72809.0 74023.6 74480.3 75445.6 66360.3 67023.7 67134.3 68480.0 69379.7 9736.2 9927.4 10003.3 10080.9 10087.8 46998.0 47903.8 48210.8 48629.8 48857.5 37769.4 53063.0 61380.8 62441.7 63510.7 12723.8 12963.9 12966.1 13350.4 13443.1 13971.4 14822.3 14823.6 14945.7 15020.4 13756.8 13878.2 14009.3 14157.4 14651.6 13368.9 13425.2 13447.7 13858.9 14208.1 13106.9 13154.5 13157.7 13212.3 13312.9 10947.0 11284.9 11599.2 11662.6 12018.2 12313.6 12527.4 12542.5 12638.1 12653.6 09:52:17 INFO - PROCESS | 15422 | -------- Summary: end -------- 09:52:17 INFO - PROCESS | 15422 | 09:52:18 INFO - TEST-INFO | 15422: exit 0 09:52:18 INFO - TEST-OK | dromaeo_css | took 1114475ms 09:52:18 INFO - TEST-START | kraken 09:52:18 INFO - operating with platform_type : linux_ 09:52:18 INFO - Initialising browser for kraken test... 09:52:18 INFO - TEST-INFO | started process 15726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmmRN3/profile http://localhost:38131/getInfo.html) 09:52:22 INFO - PROCESS | 15726 | __metrics Screen width/height:1600/1200 09:52:22 INFO - PROCESS | 15726 | colorDepth:24 09:52:22 INFO - PROCESS | 15726 | Browser inner width/height: 1024/697 09:52:22 INFO - PROCESS | 15726 | __metrics 09:52:22 INFO - PROCESS | 15726 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:22 INFO - PROCESS | 15726 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:23 INFO - PROCESS | 15726 | console.error: PushService: 09:52:23 INFO - PROCESS | 15726 | stateChangeProcessEnqueue: Error transitioning state 09:52:23 INFO - PROCESS | 15726 | UnknownError 09:52:23 INFO - TEST-INFO | 15726: exit 0 09:52:23 INFO - Browser initialized. 09:52:23 INFO - Running cycle 1/1 for kraken test... 09:52:23 INFO - TEST-INFO | started process 15818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmmRN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:35 INFO - PROCESS | 15818 | RSS: Main: 142315520 09:52:35 INFO - PROCESS | 15818 | 09:52:37 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38131/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:38 INFO - PROCESS | 15818 | RSS: Main: 183603200 09:52:38 INFO - PROCESS | 15818 | 09:52:41 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38131/tests/kraken/driver.html?testName=audio-dft) 09:52:41 INFO - PROCESS | 15818 | RSS: Main: 173842432 09:52:41 INFO - PROCESS | 15818 | 09:52:44 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38131/tests/kraken/driver.html?testName=audio-fft) 09:52:45 INFO - PROCESS | 15818 | RSS: Main: 265097216 09:52:45 INFO - PROCESS | 15818 | 09:52:47 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38131/tests/kraken/driver.html?testName=audio-oscillator) 09:52:47 INFO - PROCESS | 15818 | RSS: Main: 171159552 09:52:47 INFO - PROCESS | 15818 | 09:52:50 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38131/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:50 INFO - PROCESS | 15818 | RSS: Main: 173961216 09:52:50 INFO - PROCESS | 15818 | 09:52:53 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38131/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:54 INFO - PROCESS | 15818 | RSS: Main: 212537344 09:52:54 INFO - PROCESS | 15818 | 09:52:57 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38131/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:58 INFO - PROCESS | 15818 | RSS: Main: 211406848 09:52:58 INFO - PROCESS | 15818 | 09:53:00 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38131/tests/kraken/driver.html?testName=json-parse-financial) 09:53:01 INFO - PROCESS | 15818 | RSS: Main: 209625088 09:53:01 INFO - PROCESS | 15818 | 09:53:02 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38131/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:03 INFO - PROCESS | 15818 | RSS: Main: 172380160 09:53:03 INFO - PROCESS | 15818 | 09:53:04 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:05 INFO - PROCESS | 15818 | RSS: Main: 178843648 09:53:05 INFO - PROCESS | 15818 | 09:53:07 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:08 INFO - PROCESS | 15818 | RSS: Main: 188780544 09:53:08 INFO - PROCESS | 15818 | 09:53:10 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:11 INFO - PROCESS | 15818 | RSS: Main: 196177920 09:53:11 INFO - PROCESS | 15818 | 09:53:14 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:14 INFO - PROCESS | 15818 | RSS: Main: 193585152 09:53:14 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:38131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38131/tests/kraken/driver.html?testName=ai-astar) 09:53:16 INFO - PROCESS | 15818 | RSS: Main: 245309440 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | __start_tp_report 09:53:16 INFO - PROCESS | 15818 | _x_x_mozilla_page_load 09:53:16 INFO - PROCESS | 15818 | _x_x_mozilla_page_load_details 09:53:16 INFO - PROCESS | 15818 | |i|pagename|runs| 09:53:16 INFO - PROCESS | 15818 | |0;ai-astar;102;111;112;109;111;112;109;109;110;110 09:53:16 INFO - PROCESS | 15818 | |1;audio-beat-detection;147;122;121;154;118;118;123;120;147;117 09:53:16 INFO - PROCESS | 15818 | |2;audio-dft;161;161;161;160;162;161;162;160;160;162 09:53:16 INFO - PROCESS | 15818 | |3;audio-fft;75;75;76;111;75;76;75;76;105;76 09:53:16 INFO - PROCESS | 15818 | |4;audio-oscillator;81;81;117;81;81;82;101;81;81;104 09:53:16 INFO - PROCESS | 15818 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;116;116 09:53:16 INFO - PROCESS | 15818 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;146;147 09:53:16 INFO - PROCESS | 15818 | |7;imaging-desaturate;85;85;85;85;84;85;84;84;85;85 09:53:16 INFO - PROCESS | 15818 | |8;json-parse-financial;55;49;50;51;52;52;50;49;50;50 09:53:16 INFO - PROCESS | 15818 | |9;json-stringify-tinderbox;60;58;57;58;59;58;58;59;59;58 09:53:16 INFO - PROCESS | 15818 | |10;stanford-crypto-aes;75;75;74;75;83;78;75;77;74;80 09:53:16 INFO - PROCESS | 15818 | |11;stanford-crypto-ccm;123;142;130;124;128;126;119;120;156;121 09:53:16 INFO - PROCESS | 15818 | |12;stanford-crypto-pbkdf2;161;162;156;156;165;159;161;155;160;156 09:53:16 INFO - PROCESS | 15818 | |13;stanford-crypto-sha256-iterative;62;64;63;62;71;63;62;62;63;62 09:53:16 INFO - PROCESS | 15818 | __end_tp_report 09:53:16 INFO - PROCESS | 15818 | __start_cc_report 09:53:16 INFO - PROCESS | 15818 | _x_x_mozilla_cycle_collect,1567 09:53:16 INFO - PROCESS | 15818 | __end_cc_report 09:53:16 INFO - PROCESS | 15818 | __startTimestamp1486403596561__endTimestamp 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | ------- Summary: start ------- 09:53:16 INFO - PROCESS | 15818 | Number of tests: 14 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.88 (2.6%) stddev-sans-first:1.22 09:53:16 INFO - PROCESS | 15818 | Values: 102.0 111.0 112.0 109.0 111.0 112.0 109.0 109.0 110.0 110.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:122.50 stddev:14.48 (11.8%) stddev-sans-first:13.77 09:53:16 INFO - PROCESS | 15818 | Values: 147.0 122.0 121.0 154.0 118.0 118.0 123.0 120.0 147.0 117.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:53:16 INFO - PROCESS | 15818 | Values: 161.0 161.0 161.0 160.0 162.0 161.0 162.0 160.0 160.0 162.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:13.78 (18.3%) stddev-sans-first:14.39 09:53:16 INFO - PROCESS | 15818 | Values: 75.0 75.0 76.0 111.0 75.0 76.0 75.0 76.0 105.0 76.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.00 stddev:13.27 (16.4%) stddev-sans-first:13.76 09:53:16 INFO - PROCESS | 15818 | Values: 81.0 81.0 117.0 81.0 81.0 82.0 101.0 81.0 81.0 104.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:53:16 INFO - PROCESS | 15818 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:53:16 INFO - PROCESS | 15818 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 09:53:16 INFO - PROCESS | 15818 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 85.0 85.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:50.50 stddev:1.81 (3.6%) stddev-sans-first:1.12 09:53:16 INFO - PROCESS | 15818 | Values: 55.0 49.0 50.0 51.0 52.0 52.0 50.0 49.0 50.0 50.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 09:53:16 INFO - PROCESS | 15818 | Values: 60.0 58.0 57.0 58.0 59.0 58.0 58.0 59.0 59.0 58.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.95 (3.9%) stddev-sans-first:3.07 09:53:16 INFO - PROCESS | 15818 | Values: 75.0 75.0 74.0 75.0 83.0 78.0 75.0 77.0 74.0 80.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.00 stddev:11.62 (9.1%) stddev-sans-first:12.13 09:53:16 INFO - PROCESS | 15818 | Values: 123.0 142.0 130.0 124.0 128.0 126.0 119.0 120.0 156.0 121.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.50 stddev:3.28 (2.0%) stddev-sans-first:3.41 09:53:16 INFO - PROCESS | 15818 | Values: 161.0 162.0 156.0 156.0 165.0 159.0 161.0 155.0 160.0 156.0 09:53:16 INFO - PROCESS | 15818 | 09:53:16 INFO - PROCESS | 15818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.76 (4.4%) stddev-sans-first:2.88 09:53:16 INFO - PROCESS | 15818 | Values: 62.0 64.0 63.0 62.0 71.0 63.0 62.0 62.0 63.0 62.0 09:53:16 INFO - PROCESS | 15818 | -------- Summary: end -------- 09:53:16 INFO - PROCESS | 15818 | 09:53:17 INFO - TEST-INFO | 15818: exit 0 09:53:17 INFO - TEST-OK | kraken | took 59326ms 09:53:17 INFO - SUITE-END | took 1173s 09:53:17 INFO - Completed test suite (00:19:33) 09:53:17 INFO - javascript benchmark 09:53:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.5293982372555, 3273.214428537152, 3277.229850985018, 3300.2739397332607, 3325.0689806854075, 5477.0, 5538.307711536058, 5544.473275038875, 5548.55611551076, 5561.221428999943, 5530.391656917746, 5539.0, 5584.972075139629, 5585.832425027245, 5604.635698679583, 5017.7240251786225, 5038.5969122470115, 5074.3657042869645, 5106.744662766865, 5115.309433226504, 4896.338994235786, 4924.753762311888, 5066.594672426216, 5116.513931176551, 5123.359580052494, 5009.148444764381, 5031.044101620699, 5040.294358789773, 5052.166392545226, 5056.974715126419, 5068.619853510983, 5086.21163719624, 5143.434222235588, 5150.330457040561, 5173.637845350827, 4801.567858892717, 5036.823711170128, 5058.671186372911, 5096.9490305097215, 5124.205748109011, 5361.0, 5428.294321738149, 5437.782488700447, 5440.347158340985, 5499.340079190522, 5839.328477225131, 5846.9707651461895, 5963.19496867926, 5968.283805943272, 5971.134185543072, 5779.450952159538, 5985.25184351956, 6003.789867354665, 6013.128096426038, 6022.126791615191, 5405.000074986101, 5549.6115271930985, 5556.99974004679, 5576.470235327637, 5664.235328230636, 6041.516678665696, 6048.818535443944, 6061.030235162353, 6069.393060693896, 6118.449339559461, 5586.972065139648, 5883.0881213411985, 5883.499902508249, 5889.057750759858, 5892.175095486636, 5671.773129074791, 5868.501177399969, 5873.4126587340925, 5889.322727886262, 6006.399360064046, 5929.199558059693, 5931.08068249422, 5934.851628709317, 5938.406159384027, 5940.6435613863305, 5886.941130588725, 5945.970270148621, 5946.583739138218, 5953.434423729739, 5970.611910225822, 4477.059817438309, 4511.8646440606835, 4571.3600095986585, 4574.382458368144, 4576.931346029813, 4079.9592004080173, 4098.467199264136, 4104.794760262034, 4127.29835927887, 4138.958610413918, 5598.216249725042, 5611.130274807411, 5614.0, 5615.926712454827, 5651.2935883014625, 5746.913796293059, 5791.420857914175, 5825.679587622722, 5835.854103647358, 5920.615160014671, 5538.030844602178, 5585.944140558624, 5600.859978500489, 5606.131049687305, 5608.85977850557, 5023.09584274834, 5030.156034444156, 5032.496750324938, 5036.546710795973, 5076.898462030813, 5971.43271389226, 6001.339852616296, 6068.787592434332, 6137.079438084323, 6155.199824022849, 5804.071348584206, 5856.94143058564, 5922.200502932049, 5943.881122377615, 5988.191594134911, 6184.907226391518, 6209.720562574605, 6216.689165541615, 6217.067439884054, 6222.782202622887, 5752.7082555099, 5852.092925596539, 5860.208871802252, 5870.530357571299, 5886.735096920564, 5763.7118144093465, 5833.854153646193, 5854.677992710442, 5875.823725288077, 5895.20414744004, 5751.0, 5800.56495762811, 5817.767289308549, 5823.941760582509, 5827.067669173081, 5763.366029736641, 5797.101449275369, 5798.536117110705, 5798.623089499169, 5798.623089499169, 5566.721663916869, 5629.240052592848, 5680.062789639828, 5692.800751973661, 5776.595638305278, 5886.470217680429, 5886.646801191942, 5894.115882617471, 5908.261467316585, 5919.171316015675, 5532.861678458071, 5550.4449555044175, 5737.053386191232, 5745.942540574708, 5747.913781293368], "value": 5462.953144068999, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3742033444549, 601.2184160591231, 633.6736580660959, 644.3749562923962, 655.977040803572, 33057.0, 33534.0, 44923.77538112313, 45941.770291148496, 46193.538064619344, 42207.36688949668, 46398.30402543965, 46466.0, 46507.30239046417, 46615.53384466154, 8801.119888011212, 8918.73243802687, 8930.330225233101, 8964.596593153292, 8970.641174353019, 8156.0, 8406.621702023423, 10572.947135264312, 10757.83863242052, 10773.299735517205, 10863.402512861789, 10919.0, 10920.836187457155, 10941.671749847477, 10946.616868409606, 10663.413512256822, 10686.51910664022, 10694.144468442584, 10708.946455267713, 10720.0, 10691.679249622524, 10750.516226769814, 10757.569697212102, 10766.24636275461, 10774.838377424345, 43488.56511434877, 43549.564504355185, 43758.34362484565, 43796.78101609503, 43932.0, 3615.692666123383, 3630.455431685242, 3731.9626803731885, 3825.0, 4045.4134150548007, 32335.676643233503, 32395.51406728901, 32745.181370465692, 32837.0, 32866.6713332866, 4139.172165566869, 4172.749635021908, 4462.576055274776, 4490.932636010462, 4502.16709908668, 346839.9999999975, 347499.0, 347742.0, 350001.0, 351424.0, 61974.69012654908, 62352.688236558526, 62465.687671561354, 62567.6871615639, 62985.0, 39238.803805981355, 39732.801335993136, 39893.800530997156, 42549.0, 68096.319036809, 18955.241790328233, 19106.71339929902, 19133.904330478257, 19138.043097845053, 19140.23439062422, 11727.179097463095, 11832.76334473323, 14765.187914664582, 14875.404983800743, 14883.627909302355, 19749.308774192836, 20156.69764953527, 20202.898985504977, 21238.0, 21256.36230913075, 7255.963720181366, 7392.556446613113, 7574.583397913168, 7577.848443031108, 7623.69505219785, 935.9204467620328, 1031.4481752262504, 1031.9535620897077, 1048.3238311289329, 1076.7200527862656, 33004.1748956278, 33135.0, 33141.66858331386, 33156.33687326288, 33223.777440767815, 1087.505185140759, 1099.230538622967, 1131.728385187549, 1157.780021795856, 1226.1600803449664, 14944.252787360589, 17593.20830562602, 17962.820371796377, 18818.623627527373, 19584.804151958582, 524954.0, 526577.0, 529113.0, 532020.0, 533574.0, 60229.698851506335, 60610.09084863731, 60694.69652651709, 60695.69652151711, 60699.0, 1256.849178098634, 1301.264785396248, 1331.8601546837442, 1342.89256859451, 1346.7979803029427, 29867.253318667208, 32651.34697306088, 33917.15207119842, 33992.66007339895, 34484.31031379308, 50900.490995089574, 51400.74299628478, 51533.227001595755, 51551.0, 51564.48435515597, 300024.0, 301423.0, 302221.0, 302339.0, 302878.0, 26516.337091572866, 27500.449990999667, 29554.556681649363, 29705.405891882474, 29922.0, 48790.53622449255, 49323.50676493189, 49425.0, 49427.258591120444, 50136.74931625318, 40819.38770918498, 40868.386974194815, 41014.589854101076, 42036.0, 44682.77658611686, 41450.585494144674, 41640.16719665529, 41968.79015605024, 42459.15081698287, 43290.0, 40367.39448908327, 41811.7909410451, 42071.57928420799, 44226.778866105466, 44475.11049778922, 34680.479792802624, 38319.0, 38334.80832595819, 38574.80712596419, 39134.6086539131, 28162.2959426016, 28223.0, 28350.432991339647, 28352.0, 28359.57460638051], "value": 20605.43591553029, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.5793046266652, 402.7120608764733, 409.50245451776084, 414.67240879705037, 428.55858465780256, 14461.493847715332, 18483.907580462113, 19486.415407537796, 20218.19127234909, 20229.898850505746, 15066.698666026672, 16686.0, 19448.513787155327, 19460.70808937867, 20027.899860500715, 5787.971060144693, 5958.821235362924, 5982.461578457938, 5985.88028239435, 5985.940140598604, 5678.0, 5769.365369809318, 5888.676122813244, 5891.941080589204, 5931.970340148293, 5758.021136406821, 5759.452851979056, 5760.308762948452, 5765.279340082489, 5766.567507436938, 5604.2714447122025, 5751.712414379285, 5754.827355179351, 5825.1844741736195, 5878.50032747217, 5258.894822103536, 5265.183896496049, 5265.552428043621, 5271.130263506555, 5272.393674727417, 23090.65364019541, 23394.64908026381, 23497.17759878396, 24062.759372406403, 24544.631830522558, 2742.162234663521, 2762.4337010912714, 3146.669599692022, 3164.1931307516666, 3208.4224839528874, 14920.0, 15120.319585618674, 15308.234588270541, 15329.156896370696, 15337.846621533754, 1934.0, 1967.7245185674017, 1983.1373352591525, 1994.7706013808452, 2064.989675051615, 81623.0, 81651.0, 82972.0, 83063.5846820768, 83234.0, 10670.51982660782, 10695.73260668474, 10994.945025274823, 11083.891660025853, 11135.33188008722, 15732.05607663544, 15750.606234843992, 15750.9212453937, 15776.0, 15960.36158553668, 7420.5547667140145, 7749.690012399441, 8377.916220837713, 8408.831823363498, 8827.867581986147, 8544.273736732323, 8690.174433428814, 8767.21095101444, 8978.371513993958, 9077.133495360633, 6833.624150671761, 6839.863202735917, 6840.589564626139, 6863.588184708933, 6901.275366086589, 1944.0, 1969.8030196980187, 1995.5897466598979, 2007.1670256843247, 2054.3220737156703, 905.6694306578052, 997.2670087485692, 1013.7364285285731, 1032.9690109296732, 1046.5865982936698, 19365.0, 19489.512762180777, 20086.266732771444, 20119.0, 20537.794622053887, 991.3159919655415, 1000.3347773730533, 1008.566316483919, 1025.2925481417947, 1053.9736506587396, 9432.245420366355, 11432.599859004895, 11577.098560574848, 11614.419279036014, 11638.41807909601, 507883.0, 521103.0, 524913.0, 549236.0, 551545.0, 83343.333133337, 86107.0, 87233.56383218043, 87835.0, 89152.55423722969, 1051.4112097225577, 1052.5474046160225, 1067.6316670748733, 1073.2433634287809, 1112.4938153140301, 18166.27334906589, 18188.454346369632, 18280.268789248814, 18443.538911527317, 18714.532136696147, 40213.59786402099, 40334.1933161341, 40494.0, 40983.59016409798, 42051.1589768209, 53517.732411337696, 54212.45787542074, 54317.45682543282, 63334.0, 63844.0, 7834.412419068707, 8370.149253731342, 8393.916060839558, 8429.957850210709, 8726.781830454289, 11527.8270825936, 11552.249103808226, 11682.76634467323, 12523.812142817682, 12823.166494177849, 10752.40861752611, 10965.835512467478, 11411.60059397917, 11510.82733759011, 11512.30926144434, 11405.0, 11842.703932401759, 11919.284842909454, 12170.087243456599, 12178.45196966121, 11270.380129092979, 11455.198136130724, 11514.36670983104, 11633.825492617449, 11801.468933898166, 8416.242538171595, 8433.451825631315, 8451.070382257823, 8520.573971301534, 8635.6977505787, 9138.817223655356, 11108.88891111111, 11165.665030049111, 11346.94326528362, 11427.314361138358], "value": 9526.831586901006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1176.9470373833176, 1430.964225894353, 1468.2145052396966, 1566.6553358261185, 1722.1303241862865, 7426.368758655514, 8451.577421128943, 8669.393142480028, 8706.172913573208, 8932.910670893289, 8863.689770858022, 8904.421212621175, 8924.59839307231, 8925.821483570324, 8928.062553431893, 2472.0976843452145, 2507.7492250774867, 2510.686164229471, 2512.5351809915223, 2514.094925826701, 2429.0526694589034, 2478.615814548739, 2478.8140889433275, 2479.528889510987, 2482.2305085423577, 2469.740677228892, 2480.1815400917653, 2502.4995000999784, 2505.649209110726, 2506.2982364937848, 2386.248331775485, 2401.903923843044, 2417.190241269177, 2419.806415486757, 2423.915162969305, 2389.749076346976, 2399.124319623342, 2412.433078226615, 2415.625578035407, 2432.2460037388464, 8523.318134549221, 8602.612882420306, 8741.956290218508, 8750.518721470316, 8785.956070219672, 5246.711430871301, 5454.563634909237, 5464.508194262496, 5473.042217611942, 5483.972580137074, 3426.126337783874, 3530.4880792284976, 3571.749977501576, 3584.229390681016, 3604.567451905762, 1038.9480525973747, 1062.3413483640115, 1074.9516271767789, 1100.5267734874, 1109.1459576126338, 11797.174197806156, 11798.941005295004, 11862.52549898003, 11863.822042669453, 11874.703132421671, 4460.8661740147845, 4678.0, 4754.952450475451, 4760.738159401266, 4785.880352991134, 9558.330916835894, 9598.184154346958, 9601.663941762004, 9629.374090684083, 9665.806683866424, 5457.045017122067, 5462.071447853875, 5468.617196796186, 5476.205950137208, 5481.314835645544, 4308.9569104309185, 4475.306327519174, 4642.373279607277, 5105.336306280234, 5128.435872054071, 3925.980370098131, 3957.821898014596, 4053.473048503735, 4055.371417430303, 4062.3500239961463, 1198.26306821306, 1244.0669497876593, 1246.8690787467367, 1249.2005116725122, 1258.452573130691, 978.7944531648291, 985.6500942165571, 994.8507723841337, 996.4320337407609, 1000.7548150703125, 6039.7282122304605, 6219.440250377397, 6228.4705800007505, 6346.809595712136, 6408.00675895237, 480.61550759392344, 492.5419359995239, 494.30303272385765, 494.35486689869344, 504.88892443662337, 4138.606832350922, 4152.003519155442, 4187.958120418757, 4200.915981680349, 4203.558626344251, 10534.0, 11038.944805275922, 11040.33757974524, 11043.33739975588, 11045.83431248532, 10890.61882834097, 10977.451127443595, 10977.451127443595, 10995.450227488594, 10996.0653344465, 7815.726449574237, 8166.469179503313, 8188.50868947865, 8391.035030971394, 8416.0, 6081.239845019372, 6166.167567378347, 6245.531585131224, 6250.249970003629, 6269.467095296951, 9825.557849896915, 9980.201583873419, 10008.14930730896, 10036.447995360033, 10149.0, 8689.435186712843, 9942.701718948443, 10062.647807326708, 10095.697129086138, 10186.185105191418, 7376.96311518439, 7435.553866768011, 7535.8492830141995, 7565.962170189114, 7577.128630207376, 7883.487573307717, 7896.605169741375, 7929.484583502054, 7929.960350198212, 7933.404994625542, 7184.676689548878, 7367.668454919649, 7373.483856130019, 7423.703051877865, 7513.323800857949, 7189.604571748395, 7280.781576552712, 7295.854082918206, 7313.049303590499, 7377.4835761498325, 6917.27368626287, 6996.930030699627, 7049.118860142482, 7067.717291308496, 7127.251638578082, 5187.661026390974, 5291.3385826771655, 5317.533272051495, 5398.325209348832, 5521.0, 5304.787808487617, 5313.760880760297, 5328.254044433705, 5409.1886217066185, 5448.019356515865], "value": 4576.422668439365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7770671356905, 343.91745980964566, 349.96325385834496, 351.43068229468236, 359.0431500052359, 5248.239005344228, 5312.203169524573, 5313.468653134684, 5326.493983071602, 5343.65266257693, 5193.246979188016, 5206.3231779868565, 5217.765200565974, 5231.764570594323, 5273.736313184345, 3974.3839704845795, 4213.0, 4218.789060546976, 4248.235317642823, 4250.319948808191, 4056.290149223889, 4082.326416141333, 4152.0, 4186.267403204442, 4187.016051227959, 4114.547399786036, 4138.813753381105, 4141.979290103561, 4151.149014452045, 4157.355609880473, 4142.896427589304, 4146.398772178048, 4160.2303573838935, 4169.687273454473, 4176.310908700061, 3496.7727097738566, 3505.2989402119424, 3681.226942342111, 3702.018964974284, 3719.7210209234418, 5119.513646203642, 5122.231665250205, 5124.718140502271, 5127.410347809975, 5145.33110695611, 4739.668223224376, 4758.025419450923, 4765.26138448541, 4770.546798054179, 4772.976135119302, 5400.460868652415, 5502.413865483217, 5505.6696598204235, 5517.9443109314625, 5529.0, 4101.323281658522, 4104.281750693646, 4107.322291821846, 4110.047727329525, 4111.629953304187, 5693.0, 5703.233931543198, 5711.971440142815, 5712.685802280873, 5723.284589426322, 4029.174019326031, 4202.159568086395, 4223.746575205498, 4231.196072746168, 4237.745735255895, 4259.339802330644, 4262.680298977589, 4266.509351424564, 4284.742915425085, 4298.3552467130185, 4773.403324584427, 4791.832285869978, 4797.712137271775, 4798.568128868349, 4800.831970881002, 5352.892942141136, 5519.31008623922, 5560.638558493685, 5563.13771365439, 5563.972180139154, 1429.2353590828857, 1434.7202295552477, 1438.9711356380237, 1442.2572375226766, 1445.3279225160352, 969.9709008729608, 1017.3793985668736, 1024.764304210021, 1027.1320733979776, 1030.2788048366174, 5110.71891045996, 5168.819091331786, 5169.638125331191, 5178.741062946838, 5204.8178313758835, 5487.835364938978, 5566.499015088581, 5628.324601047901, 5641.9435805641415, 5669.6314739541795, 5357.464253574689, 5372.328458942632, 5385.380681221632, 5389.865253368697, 5390.434004429479, 2805.7474827265237, 2896.942061158807, 2898.449294634055, 2899.7535209507428, 2920.269932516871, 5719.656820590778, 5719.914201286984, 5736.942630573724, 5741.483266506035, 5743.913841292384, 5620.634658747168, 5628.71856407178, 5633.887322253532, 5635.605507614428, 5639.943600563942, 5455.372632147274, 5687.829365119053, 5714.828555143353, 5741.799037033684, 5768.855778605568, 5400.864978375572, 5419.05166595852, 5433.673979561239, 5468.589855760913, 5471.562275018068, 5198.532132108128, 5442.23808666779, 5447.700376479332, 5450.874159077884, 5452.400235974119, 5632.324121105494, 5705.486506214461, 5709.9714501427225, 5711.657300561979, 5750.856228594152, 4125.793710314532, 4128.793560321912, 4130.05887233, 4155.5013398391175, 4156.272652285898, 5282.234076058873, 5385.892282154413, 5505.119180931032, 5508.256385387921, 5517.310336207974, 5365.892682146413, 5377.2740680009265, 5412.350517937715, 5428.83713488596, 5463.535599474089, 5297.973510132425, 5376.704281264568, 5387.892242155213, 5407.918416316674, 5433.510984011458, 5080.568151707146, 5325.813596524103, 5357.678539287655, 5374.355077390738, 5381.838544843661, 5363.517283444508, 5379.704116273642, 5399.759099973624, 5400.459954004568, 5416.0, 5302.496262855023, 5357.410684824588, 5461.235427040138, 5465.152901300305, 5478.45215478449], "value": 4216.795512510925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.8703389872873, 721.747388414055, 733.2557454184001, 754.2758951406649, 805.7864665863543, 14476.565703028913, 15102.471413500529, 15125.16811575363, 15132.167730774803, 15181.39274429023, 13711.65720856979, 14047.36786844592, 14070.859291407083, 14083.0, 14121.223332716696, 697.9930200697979, 721.0410154494535, 782.0927723840347, 791.3669064748207, 834.1075049696827, 851.4082712514804, 854.7948492361851, 855.1533981358441, 856.0882659967147, 856.4604299291437, 883.7525492862009, 885.8848349714528, 886.0342226972599, 888.1606881496988, 888.4225253585157, 873.5195642396689, 875.4222213339166, 875.6322344615277, 878.6792820620492, 878.9077146899548, 648.4488185042676, 650.4146268358515, 651.2022772104182, 651.9315471875432, 654.5516321319864, 13453.327333633377, 13678.042537022413, 13715.245661488614, 13737.519186828513, 15061.096334219981, 14755.483558075523, 15216.467423640119, 15328.693426131415, 15454.61363465911, 15483.845161548354, 11465.254758440758, 11492.770144597145, 11656.125790565742, 11747.47136378865, 12071.215371000944, 4446.599806017474, 4505.504394516601, 4506.324051392285, 4513.638908887281, 4529.660275479352, 65246.673766631335, 65319.3468065318, 65586.34413655898, 66287.0, 68552.65723671399, 10462.947685261524, 10721.0, 10776.137908967265, 11073.612423565137, 11077.11383089351, 19184.424467266006, 19366.70949935752, 19395.127219274884, 19417.80582194188, 19444.319448819508, 8209.09699933007, 8232.0, 8586.828263434822, 8616.48301101936, 9032.503212323385, 4758.619310455155, 4850.708957462493, 4890.853274401774, 4907.190313598217, 4961.925571116436, 3477.808720520345, 3554.662307080875, 3562.87529936451, 3571.089372210122, 3613.6928361089076, 635.1203583037434, 647.0423772816164, 662.5395350231543, 668.6890595872942, 669.1902797614844, 750.8761054426068, 765.8430021845509, 775.918528554505, 790.4624855098588, 798.4211446701095, 8945.552722363856, 9184.72445826613, 9369.205471783938, 9490.762730931781, 9519.0, 634.3022675057492, 645.5868244323636, 747.4468893019235, 748.4910261022449, 752.8193233623891, 4704.341392205094, 4922.72924989129, 4952.727599982036, 4968.130577148984, 4975.278584605285, 71895.0, 72245.63877180581, 74012.25987740053, 87588.56205718931, 90188.0, 70491.2950870495, 72809.0, 74023.62988185132, 74480.25519744733, 75445.62277188578, 66360.33639663638, 67023.66488167529, 67134.32865671281, 68480.0, 69379.65310173416, 9736.221102311656, 9927.40435573868, 10003.292525966162, 10080.94959525227, 10087.848682269918, 46998.0, 47903.76048119737, 48210.758946205046, 48629.75685121552, 48857.5114248853, 37769.433458498694, 53063.0, 61380.772384552954, 62441.687791560755, 63510.68244658932, 12723.80914286268, 12963.935180324039, 12966.092373533762, 13350.399232034775, 13443.126196797177, 13971.441142354191, 14822.332995015035, 14823.629409264855, 14945.701085978002, 15020.399184032953, 13756.76189142982, 13878.236696981763, 14009.299535023412, 14157.43370265219, 14651.560453186421, 13368.866311336762, 13425.194488330731, 13447.731045379232, 13858.86141138616, 14208.147511149364, 13106.868931310946, 13154.473821047433, 13157.736845262849, 13212.339383030618, 13312.933435332761, 10947.0, 11284.887151128713, 11599.188056835941, 11662.591809286634, 12018.158728888893, 12313.630591082281, 12527.37363131858, 12542.49830006826, 12638.115331926678, 12653.557125500563], "value": 7338.773393445533, "unit": "score"}], "name": "dromaeo_css", "value": 7304.4816053885015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 109.0, 111.0, 112.0, 109.0, 109.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 121.0, 154.0, 118.0, 118.0, 123.0, 120.0, 147.0, 117.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 162.0, 160.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 111.0, 75.0, 76.0, 75.0, 76.0, 105.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 117.0, 81.0, 81.0, 82.0, 101.0, 81.0, 81.0, 104.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 49.0, 50.0, 51.0, 52.0, 52.0, 50.0, 49.0, 50.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 57.0, 58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 75.0, 83.0, 78.0, 75.0, 77.0, 74.0, 80.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 142.0, 130.0, 124.0, 128.0, 126.0, 119.0, 120.0, 156.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 156.0, 156.0, 165.0, 159.0, 161.0, 155.0, 160.0, 156.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 62.0, 71.0, 63.0, 62.0, 62.0, 63.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1455.4, "alertThreshold": 2.0}]} 09:53:17 INFO - Return code: 0 09:53:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:17 INFO - # TBPL SUCCESS # 09:53:17 INFO - Running post-action listener: _resource_record_post_action 09:53:17 INFO - [mozharness: 2017-02-06 17:53:17.842761Z] Finished run-tests step (success) 09:53:17 INFO - Running post-run listener: _resource_record_post_run 09:53:17 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310915072; Read time: 16; Write time: 159212 09:53:17 INFO - TinderboxPrint: CPU usage
13.0% 09:53:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:53:17 INFO - TinderboxPrint: I/O write bytes / time
310,915,072 / 159,212 09:53:17 INFO - TinderboxPrint: CPU idle
8,252.2 (87.0%) 09:53:17 INFO - TinderboxPrint: CPU user
1,188.1 (12.5%) 09:53:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:53:17 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101027840; Read time: 0; Write time: 79660 09:53:17 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 209887232; Read time: 0; Write time: 79552 09:53:18 INFO - Running post-run listener: _upload_blobber_files 09:53:18 INFO - Blob upload gear active. 09:53:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:18 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 09:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:19 INFO - (blobuploader) - INFO - Done attempting. 09:53:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:53:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:53:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:20 INFO - (blobuploader) - INFO - Done attempting. 09:53:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:23 INFO - (blobuploader) - INFO - Done attempting. 09:53:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:23 INFO - Return code: 0 09:53:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21635dac53ba05f3418588867dfdb901dbd8179cb61744ac54e86b441b6ce5f54ad90fba19a9fcf7ff42f26144618b99e079b83c8868cc62aa835d0ad3573110", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/560dd036845bb249468035e1c0f2f4b19fd485942b0bfcc63eef05e341443c981b373e57d7dd739e6f2e1db370cedd3adb846e3941c8310b932575aefc7d81dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e006218866abc0fcd0926bc845973338c147023c4a3b5dd39fd39bca0a9a4f4bf93bf6a9f6a3c0b4a559a84136c7ec2734e2b7d7234954ba929e0d2ea2d5247"} 09:53:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:23 INFO - Contents: 09:53:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21635dac53ba05f3418588867dfdb901dbd8179cb61744ac54e86b441b6ce5f54ad90fba19a9fcf7ff42f26144618b99e079b83c8868cc62aa835d0ad3573110", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/560dd036845bb249468035e1c0f2f4b19fd485942b0bfcc63eef05e341443c981b373e57d7dd739e6f2e1db370cedd3adb846e3941c8310b932575aefc7d81dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e006218866abc0fcd0926bc845973338c147023c4a3b5dd39fd39bca0a9a4f4bf93bf6a9f6a3c0b4a559a84136c7ec2734e2b7d7234954ba929e0d2ea2d5247"} 09:53:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:23 INFO - Copying logs to upload dir... 09:53:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.886846 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-02-06 09:53:23.074824) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 09:53:23.078649) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21635dac53ba05f3418588867dfdb901dbd8179cb61744ac54e86b441b6ce5f54ad90fba19a9fcf7ff42f26144618b99e079b83c8868cc62aa835d0ad3573110", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/560dd036845bb249468035e1c0f2f4b19fd485942b0bfcc63eef05e341443c981b373e57d7dd739e6f2e1db370cedd3adb846e3941c8310b932575aefc7d81dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e006218866abc0fcd0926bc845973338c147023c4a3b5dd39fd39bca0a9a4f4bf93bf6a9f6a3c0b4a559a84136c7ec2734e2b7d7234954ba929e0d2ea2d5247"} build_url:https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/TOXPIwYoRy2LApZoToHb-Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21635dac53ba05f3418588867dfdb901dbd8179cb61744ac54e86b441b6ce5f54ad90fba19a9fcf7ff42f26144618b99e079b83c8868cc62aa835d0ad3573110", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/560dd036845bb249468035e1c0f2f4b19fd485942b0bfcc63eef05e341443c981b373e57d7dd739e6f2e1db370cedd3adb846e3941c8310b932575aefc7d81dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e006218866abc0fcd0926bc845973338c147023c4a3b5dd39fd39bca0a9a4f4bf93bf6a9f6a3c0b4a559a84136c7ec2734e2b7d7234954ba929e0d2ea2d5247"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 09:53:23.104312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:53:23.104612) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1486402369.280108-155423960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004719 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:53:23.190237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 09:53:23.190762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 09:53:23.191277) ========= ========= Total master_lag: 0.16 =========