builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1484276065.52 results: success (0) buildid: 20170112171016 builduid: 31378b68920747828e93725e8ffa0c65 revision: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.520883) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.521347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.521619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.538014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.538593) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 18:54:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.0M=0s 2017-01-12 18:54:26 (70.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120966 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.673580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.673892) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017192 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.726741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:25.727101) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 --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=a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 18:54:26,655 truncating revision to first 12 chars 2017-01-12 18:54:26,656 Setting DEBUG logging. 2017-01-12 18:54:26,656 attempt 1/10 2017-01-12 18:54:26,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1e322cd9c741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 18:54:26,953 unpacking tar archive at: mozilla-aurora-1e322cd9c741/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:26.359192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:26.359503) ========= script_repo_revision: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:26.359885) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:26.360167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 18:54:26.375549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 18:54:26.375937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:54:27 INFO - MultiFileLogger online at 20170112 18:54:27 in /builds/slave/test 18:54:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:54:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:54:27 INFO - {'append_to_log': False, 18:54:27 INFO - 'base_work_dir': '/builds/slave/test', 18:54:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:54:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:54:27 INFO - 'branch': 'Mozilla-Aurora', 18:54:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:54:27 INFO - 'config_files': ('talos/linux_config.py',), 18:54:27 INFO - 'default_actions': ('clobber', 18:54:27 INFO - 'read-buildbot-config', 18:54:27 INFO - 'download-and-extract', 18:54:27 INFO - 'populate-webroot', 18:54:27 INFO - 'create-virtualenv', 18:54:27 INFO - 'install', 18:54:27 INFO - 'run-tests'), 18:54:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:54:27 INFO - 'download_minidump_stackwalk': True, 18:54:27 INFO - 'download_symbols': 'ondemand', 18:54:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:54:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:54:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:54:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:54:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:54:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:54:27 INFO - 'installer_path': 'installer.exe', 18:54:27 INFO - 'log_level': 'info', 18:54:27 INFO - 'log_name': 'talos', 18:54:27 INFO - 'log_to_console': True, 18:54:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:54:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:54:27 INFO - 'opt_config_files': (), 18:54:27 INFO - 'pip_index': False, 18:54:27 INFO - 'sps_profile': False, 18:54:27 INFO - 'sps_profile_interval': 0, 18:54:27 INFO - 'suite': 'dromaeojs', 18:54:27 INFO - 'system_bits': '32', 18:54:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:54:27 INFO - 'title': 'talos-linux64-ix-064', 18:54:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:54:27 INFO - 'use_talos_json': True, 18:54:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:54:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:54:27 INFO - 'work_dir': 'build'} 18:54:27 INFO - [mozharness: 2017-01-13 02:54:27.397076Z] Running clobber step. 18:54:27 INFO - Running pre-action listener: _resource_record_pre_action 18:54:27 INFO - Running main action method: clobber 18:54:27 INFO - rmtree: /builds/slave/test/build 18:54:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:54:28 INFO - Running post-action listener: _resource_record_post_action 18:54:28 INFO - [mozharness: 2017-01-13 02:54:28.376619Z] Finished clobber step (success) 18:54:28 INFO - [mozharness: 2017-01-13 02:54:28.376717Z] Running read-buildbot-config step. 18:54:28 INFO - Running pre-action listener: _resource_record_pre_action 18:54:28 INFO - Running main action method: read_buildbot_config 18:54:28 INFO - Using buildbot properties: 18:54:28 INFO - { 18:54:28 INFO - "project": "", 18:54:28 INFO - "product": "firefox", 18:54:28 INFO - "script_repo_revision": "production", 18:54:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:54:28 INFO - "repository": "", 18:54:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:54:28 INFO - "buildid": "20170112171016", 18:54:28 INFO - "pgo_build": "True", 18:54:28 INFO - "basedir": "/builds/slave/test", 18:54:28 INFO - "buildnumber": 738, 18:54:28 INFO - "slavename": "talos-linux64-ix-064", 18:54:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:54:28 INFO - "platform": "ubuntu64_hw", 18:54:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:54:28 INFO - "branch": "mozilla-aurora", 18:54:28 INFO - "repo_path": "releases/mozilla-aurora", 18:54:28 INFO - "revision": "1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6", 18:54:28 INFO - "stage_platform": "linux64-pgo", 18:54:28 INFO - "builduid": "31378b68920747828e93725e8ffa0c65", 18:54:28 INFO - "slavebuilddir": "test" 18:54:28 INFO - } 18:54:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 18:54:28 INFO - Running post-action listener: _resource_record_post_action 18:54:28 INFO - [mozharness: 2017-01-13 02:54:28.379554Z] Finished read-buildbot-config step (success) 18:54:28 INFO - [mozharness: 2017-01-13 02:54:28.379641Z] Running download-and-extract step. 18:54:28 INFO - Running pre-action listener: _resource_record_pre_action 18:54:28 INFO - Running main action method: download_and_extract 18:54:28 INFO - mkdir: /builds/slave/test/build/tests 18:54: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')]} 18:54:28 INFO - trying https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 18:54:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 18:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:54:28 INFO - Downloaded 1361 bytes. 18:54:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 18:54:28 INFO - Using the following test package requirements: 18:54:28 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 18:54:28 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:54:28 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:54:28 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'jsshell-linux-x86_64.zip'], 18:54:28 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:54:28 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 18:54:28 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:54:28 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:54:28 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:54:28 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 18:54:28 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:54:28 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:54:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 18:54:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 18:54:29 INFO - Http code: 200 18:54:29 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 18:54:29 INFO - x-amz-cf-id: -FkAF2RKKreAiwt1tWLR3ayH389siwmy4VsEKAzJx0gIaSEtprDzmA== 18:54:29 INFO - x-amz-version-id: hO4i9GCtGa_V8II9sPCp2m1kQPr4EaOS 18:54:29 INFO - Expected file size: 21947580 18:54:29 INFO - Obtained file size: 21947580 18:54:33 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:54:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 18:54:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 18:54:34 INFO - Http code: 200 18:54:34 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 18:54:34 INFO - x-amz-cf-id: usM6uuSPb_Q1100ao8Sw6qxnh2ia8pkTi3v6Z54pvm_0LXlQxPjD2A== 18:54:34 INFO - x-amz-version-id: hO4i9GCtGa_V8II9sPCp2m1kQPr4EaOS 18:54:34 INFO - Expected file size: 21947580 18:54:34 INFO - Obtained file size: 21947580 18:54:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 18:54:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:54:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 18:54:39 INFO - Http code: 200 18:54:39 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 18:54:39 INFO - x-amz-cf-id: HSgnHHqtcOQkwbfSaCMwo_0w5lX6bO-45-rj0elfyeyu6MGBmzy2PQ== 18:54:39 INFO - x-amz-version-id: sE7H613sCdJOHWH3Wn.lWqLGZr6TeofV 18:54:39 INFO - Expected file size: 14409038 18:54:39 INFO - Obtained file size: 14409038 18:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:39 INFO - trying https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:54:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:54:41 INFO - Downloaded 64160783 bytes. 18:54:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:54:41 INFO - mkdir: /builds/slave/test/properties 18:54:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:54:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:54:41 INFO - Contents: 18:54:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 18:54:41 INFO - Running post-action listener: _resource_record_post_action 18:54:41 INFO - Running post-action listener: set_extra_try_arguments 18:54:41 INFO - [mozharness: 2017-01-13 02:54:41.703308Z] Finished download-and-extract step (success) 18:54:41 INFO - [mozharness: 2017-01-13 02:54:41.703534Z] Running populate-webroot step. 18:54:41 INFO - Running pre-action listener: _resource_record_pre_action 18:54:41 INFO - Running main action method: populate_webroot 18:54:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:54:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:54:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:54:41 INFO - '--tppagecycles', 18:54:41 INFO - '7'], 18:54:41 INFO - 'tests': ['tsvgm']}}, 18:54:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:54:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:54:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:54:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:54:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['damp', 'tps']}, 18:54:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'tests': ['damp', 'tps']}, 18:54:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['dromaeo_dom']}, 18:54:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:54:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['basic_compositor_video']}, 18:54:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:54:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['a11yr', 18:54:41 INFO - 'ts_paint', 18:54:41 INFO - 'tpaint', 18:54:41 INFO - 'sessionrestore', 18:54:41 INFO - 'sessionrestore_no_auto_restore', 18:54:41 INFO - 'tabpaint']}, 18:54:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:54:41 INFO - 'ts_paint', 18:54:41 INFO - 'tpaint', 18:54:41 INFO - 'sessionrestore', 18:54:41 INFO - 'sessionrestore_no_auto_restore', 18:54:41 INFO - 'tabpaint']}, 18:54:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:54:41 INFO - 'ts_paint', 18:54:41 INFO - 'tpaint', 18:54:41 INFO - 'sessionrestore', 18:54:41 INFO - 'sessionrestore_no_auto_restore', 18:54:41 INFO - 'tabpaint']}, 18:54:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:54:41 INFO - 'ts_paint', 18:54:41 INFO - 'tpaint', 18:54:41 INFO - 'sessionrestore', 18:54:41 INFO - 'sessionrestore_no_auto_restore', 18:54:41 INFO - 'tabpaint']}, 18:54:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['a11yr', 18:54:41 INFO - 'ts_paint', 18:54:41 INFO - 'tpaint', 18:54:41 INFO - 'sessionrestore', 18:54:41 INFO - 'sessionrestore_no_auto_restore', 18:54:41 INFO - 'tabpaint']}, 18:54:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['a11yr', 18:54:41 INFO - 'ts_paint', 18:54:41 INFO - 'tpaint', 18:54:41 INFO - 'sessionrestore', 18:54:41 INFO - 'sessionrestore_no_auto_restore', 18:54:41 INFO - 'tabpaint']}, 18:54:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['tsvgx', 18:54:41 INFO - 'tsvgr_opacity', 18:54:41 INFO - 'tart', 18:54:41 INFO - 'tscrollx', 18:54:41 INFO - 'cart']}, 18:54:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:54:41 INFO - 'tsvgr_opacity', 18:54:41 INFO - 'tart', 18:54:41 INFO - 'tscrollx', 18:54:41 INFO - 'cart']}, 18:54:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'talos_options': ['--disable-e10s'], 18:54:41 INFO - 'tests': ['tp5o']}, 18:54:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'tests': ['tp5o']}, 18:54:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'talos_options': ['--disable-e10s', 18:54:41 INFO - '--xperf_path', 18:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:41 INFO - 'tests': ['tp5n']}, 18:54:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:41 INFO - 'talos_options': ['--xperf_path', 18:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:41 INFO - 'tests': ['tp5n']}}, 18:54:41 INFO - 'talos.zip': {'path': '', 18:54:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:54:41 INFO - Running post-action listener: _resource_record_post_action 18:54:41 INFO - [mozharness: 2017-01-13 02:54:41.725855Z] Finished populate-webroot step (success) 18:54:41 INFO - [mozharness: 2017-01-13 02:54:41.725942Z] Running create-virtualenv step. 18:54:41 INFO - Running pre-action listener: _resource_record_pre_action 18:54:41 INFO - Running main action method: create_virtualenv 18:54:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:54:41 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 18:54:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:54:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:54:41 INFO - Using real prefix '/usr' 18:54:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:54:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:54:44 INFO - Installing pip.................done. 18:54:44 INFO - Return code: 0 18:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:54:44 INFO - Reading from file tmpfile_stdout 18:54:44 INFO - Output received: 18:54:44 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) 18:54:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:44 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:44 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 18:54:44 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 18:54:44 INFO - Using env: {'DISPLAY': ':0', 18:54:44 INFO - 'HOME': '/home/cltbld', 18:54:44 INFO - 'LANG': 'en_US.UTF-8', 18:54:44 INFO - 'LANGUAGE': 'en_US:en', 18:54:44 INFO - 'LOGNAME': 'cltbld', 18:54:44 INFO - 'MAIL': '/var/mail/cltbld', 18:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:44 INFO - 'MOZ_NO_REMOTE': '1', 18:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:44 INFO - 'NO_EM_RESTART': '1', 18:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:44 INFO - 'PWD': '/builds/slave/test', 18:54:44 INFO - 'SHELL': '/bin/bash', 18:54:44 INFO - 'SHLVL': '1', 18:54:44 INFO - 'TERM': 'linux', 18:54:44 INFO - 'TMOUT': '86400', 18:54:44 INFO - 'USER': 'cltbld', 18:54:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:44 INFO - '_': '/tools/buildbot/bin/python'} 18:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:44 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 18:54:44 INFO - Cleaning up... 18:54:44 INFO - Return code: 0 18:54:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:44 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:44 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 18:54:44 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 18:54:44 INFO - Using env: {'DISPLAY': ':0', 18:54:44 INFO - 'HOME': '/home/cltbld', 18:54:44 INFO - 'LANG': 'en_US.UTF-8', 18:54:44 INFO - 'LANGUAGE': 'en_US:en', 18:54:44 INFO - 'LOGNAME': 'cltbld', 18:54:44 INFO - 'MAIL': '/var/mail/cltbld', 18:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:44 INFO - 'MOZ_NO_REMOTE': '1', 18:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:44 INFO - 'NO_EM_RESTART': '1', 18:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:44 INFO - 'PWD': '/builds/slave/test', 18:54:44 INFO - 'SHELL': '/bin/bash', 18:54:44 INFO - 'SHLVL': '1', 18:54:44 INFO - 'TERM': 'linux', 18:54:44 INFO - 'TMOUT': '86400', 18:54:44 INFO - 'USER': 'cltbld', 18:54:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:44 INFO - '_': '/tools/buildbot/bin/python'} 18:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:44 INFO - Downloading/unpacking psutil>=3.1.1 18:54:44 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 18:54:44 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 18:54:44 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 18:54:44 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 18:54:44 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 18:54:44 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 18:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:47 INFO - Installing collected packages: psutil 18:54:47 INFO - Running setup.py install for psutil 18:54:47 INFO - building 'psutil._psutil_linux' extension 18:54:47 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 18:54:47 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 18:54:47 INFO - building 'psutil._psutil_posix' extension 18:54:47 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 18:54:47 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 18:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:47 INFO - Successfully installed psutil 18:54:47 INFO - Cleaning up... 18:54:47 INFO - Return code: 0 18:54:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:54:47 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')]} 18:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:47 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')]} 18:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:47 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:47 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 18:54:47 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 18:54:47 INFO - Using env: {'DISPLAY': ':0', 18:54:47 INFO - 'HOME': '/home/cltbld', 18:54:47 INFO - 'LANG': 'en_US.UTF-8', 18:54:47 INFO - 'LANGUAGE': 'en_US:en', 18:54:47 INFO - 'LOGNAME': 'cltbld', 18:54:47 INFO - 'MAIL': '/var/mail/cltbld', 18:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:47 INFO - 'MOZ_NO_REMOTE': '1', 18:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:47 INFO - 'NO_EM_RESTART': '1', 18:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:47 INFO - 'PWD': '/builds/slave/test', 18:54:47 INFO - 'SHELL': '/bin/bash', 18:54:47 INFO - 'SHLVL': '1', 18:54:47 INFO - 'TERM': 'linux', 18:54:47 INFO - 'TMOUT': '86400', 18:54:47 INFO - 'USER': 'cltbld', 18:54:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:47 INFO - '_': '/tools/buildbot/bin/python'} 18:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:54:47 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 18:54:47 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 18:54:47 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 18:54:47 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 18:54:47 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 18:54:47 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 18:54:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:54:49 INFO - Installing collected packages: mozsystemmonitor 18:54:49 INFO - Running setup.py install for mozsystemmonitor 18:54:49 INFO - Successfully installed mozsystemmonitor 18:54:49 INFO - Cleaning up... 18:54:50 INFO - Return code: 0 18:54:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:54:50 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')]} 18:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:50 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')]} 18:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:50 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:50 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 18:54:50 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 18:54:50 INFO - Using env: {'DISPLAY': ':0', 18:54:50 INFO - 'HOME': '/home/cltbld', 18:54:50 INFO - 'LANG': 'en_US.UTF-8', 18:54:50 INFO - 'LANGUAGE': 'en_US:en', 18:54:50 INFO - 'LOGNAME': 'cltbld', 18:54:50 INFO - 'MAIL': '/var/mail/cltbld', 18:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:50 INFO - 'MOZ_NO_REMOTE': '1', 18:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:50 INFO - 'NO_EM_RESTART': '1', 18:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:50 INFO - 'PWD': '/builds/slave/test', 18:54:50 INFO - 'SHELL': '/bin/bash', 18:54:50 INFO - 'SHLVL': '1', 18:54:50 INFO - 'TERM': 'linux', 18:54:50 INFO - 'TMOUT': '86400', 18:54:50 INFO - 'USER': 'cltbld', 18:54:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:50 INFO - '_': '/tools/buildbot/bin/python'} 18:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:50 INFO - Downloading/unpacking jsonschema==2.5.1 18:54:50 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 18:54:50 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 18:54:50 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 18:54:50 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 18:54:50 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 18:54:50 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 18:54:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:52 INFO - warning: no files found matching '*.txt' 18:54:52 INFO - no previously-included directories found matching 'build' 18:54:52 INFO - no previously-included directories found matching 'dist' 18:54:52 INFO - no previously-included directories found matching '.git*' 18:54:52 INFO - Installing collected packages: jsonschema, functools32 18:54:52 INFO - Running setup.py install for functools32 18:54:52 INFO - warning: no files found matching '*.txt' 18:54:52 INFO - no previously-included directories found matching 'build' 18:54:52 INFO - no previously-included directories found matching 'dist' 18:54:52 INFO - no previously-included directories found matching '.git*' 18:54:52 INFO - Successfully installed jsonschema functools32 18:54:52 INFO - Cleaning up... 18:54:52 INFO - Return code: 0 18:54:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:54: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')]} 18:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:54:52 INFO - Using env: {'DISPLAY': ':0', 18:54:52 INFO - 'HOME': '/home/cltbld', 18:54:52 INFO - 'LANG': 'en_US.UTF-8', 18:54:52 INFO - 'LANGUAGE': 'en_US:en', 18:54:52 INFO - 'LOGNAME': 'cltbld', 18:54:52 INFO - 'MAIL': '/var/mail/cltbld', 18:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:52 INFO - 'MOZ_NO_REMOTE': '1', 18:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:52 INFO - 'NO_EM_RESTART': '1', 18:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:52 INFO - 'PWD': '/builds/slave/test', 18:54:52 INFO - 'SHELL': '/bin/bash', 18:54:52 INFO - 'SHLVL': '1', 18:54:52 INFO - 'TERM': 'linux', 18:54:52 INFO - 'TMOUT': '86400', 18:54:52 INFO - 'USER': 'cltbld', 18:54:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:52 INFO - '_': '/tools/buildbot/bin/python'} 18:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:54:52 INFO - Cleaning up... 18:54:52 INFO - Return code: 0 18:54:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:54: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')]} 18:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:53 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:53 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 18:54:53 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 18:54:53 INFO - Using env: {'DISPLAY': ':0', 18:54:53 INFO - 'HOME': '/home/cltbld', 18:54:53 INFO - 'LANG': 'en_US.UTF-8', 18:54:53 INFO - 'LANGUAGE': 'en_US:en', 18:54:53 INFO - 'LOGNAME': 'cltbld', 18:54:53 INFO - 'MAIL': '/var/mail/cltbld', 18:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:53 INFO - 'MOZ_NO_REMOTE': '1', 18:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:53 INFO - 'NO_EM_RESTART': '1', 18:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:53 INFO - 'PWD': '/builds/slave/test', 18:54:53 INFO - 'SHELL': '/bin/bash', 18:54:53 INFO - 'SHLVL': '1', 18:54:53 INFO - 'TERM': 'linux', 18:54:53 INFO - 'TMOUT': '86400', 18:54:53 INFO - 'USER': 'cltbld', 18:54:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:53 INFO - '_': '/tools/buildbot/bin/python'} 18:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:54:53 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 18:54:53 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 18:54:53 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 18:54:53 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 18:54:53 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 18:54:53 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 18:54:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:54:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:54:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 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 18:54:55 INFO - Downloading docopt-0.6.1.tar.gz 18:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:54:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:54:56 INFO - Running setup.py install for blobuploader 18:54:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:54:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:54:56 INFO - Running setup.py install for requests 18:54:56 INFO - Running setup.py install for docopt 18:54:56 INFO - Successfully installed blobuploader requests docopt 18:54:56 INFO - Cleaning up... 18:54:56 INFO - Return code: 0 18:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:56 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:56 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 18:54:56 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 18:54:56 INFO - Using env: {'DISPLAY': ':0', 18:54:56 INFO - 'HOME': '/home/cltbld', 18:54:56 INFO - 'LANG': 'en_US.UTF-8', 18:54:56 INFO - 'LANGUAGE': 'en_US:en', 18:54:56 INFO - 'LOGNAME': 'cltbld', 18:54:56 INFO - 'MAIL': '/var/mail/cltbld', 18:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:56 INFO - 'MOZ_NO_REMOTE': '1', 18:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:56 INFO - 'NO_EM_RESTART': '1', 18:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:56 INFO - 'PWD': '/builds/slave/test', 18:54:56 INFO - 'SHELL': '/bin/bash', 18:54:56 INFO - 'SHLVL': '1', 18:54:56 INFO - 'TERM': 'linux', 18:54:56 INFO - 'TMOUT': '86400', 18:54:56 INFO - 'USER': 'cltbld', 18:54:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:56 INFO - '_': '/tools/buildbot/bin/python'} 18:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:56 INFO - Running setup.py (path:/tmp/pip-Inq1xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:56 INFO - Running setup.py (path:/tmp/pip-YYdGY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:56 INFO - Running setup.py (path:/tmp/pip-ZNVAbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:57 INFO - Running setup.py (path:/tmp/pip-Dq7uJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:57 INFO - Running setup.py (path:/tmp/pip-HMk7Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:57 INFO - Running setup.py (path:/tmp/pip-aM79ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:57 INFO - Running setup.py (path:/tmp/pip-0eiW5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:57 INFO - Running setup.py (path:/tmp/pip-LcFdRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:57 INFO - Running setup.py (path:/tmp/pip-gyvaK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:57 INFO - Running setup.py (path:/tmp/pip-v4GjYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:57 INFO - Running setup.py (path:/tmp/pip-bhzr1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:57 INFO - Running setup.py (path:/tmp/pip-m4bHZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:57 INFO - Running setup.py (path:/tmp/pip-slbEsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:57 INFO - Running setup.py (path:/tmp/pip-v9avAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:57 INFO - Running setup.py (path:/tmp/pip-pEeamc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:57 INFO - Running setup.py (path:/tmp/pip-TxSuZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:58 INFO - Running setup.py (path:/tmp/pip-t8EGTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:54:58 INFO - Running setup.py install for manifestparser 18:54:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Running setup.py install for mozcrash 18:54:58 INFO - Running setup.py install for mozdebug 18:54:58 INFO - Running setup.py install for mozdevice 18:54:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Running setup.py install for mozfile 18:54:58 INFO - Running setup.py install for mozhttpd 18:54:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Running setup.py install for mozinfo 18:54:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Running setup.py install for mozInstall 18:54:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:54:58 INFO - Running setup.py install for mozleak 18:54:58 INFO - Running setup.py install for mozlog 18:54:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for moznetwork 18:54:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozprocess 18:54:59 INFO - Running setup.py install for mozprofile 18:54:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozrunner 18:54:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Running setup.py install for mozscreenshot 18:54:59 INFO - Running setup.py install for moztest 18:54:59 INFO - Running setup.py install for mozversion 18:54:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:54:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:54:59 INFO - Cleaning up... 18:54:59 INFO - Return code: 0 18:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:59 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:54:59 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 18:54:59 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 18:54:59 INFO - Using env: {'DISPLAY': ':0', 18:54:59 INFO - 'HOME': '/home/cltbld', 18:54:59 INFO - 'LANG': 'en_US.UTF-8', 18:54:59 INFO - 'LANGUAGE': 'en_US:en', 18:54:59 INFO - 'LOGNAME': 'cltbld', 18:54:59 INFO - 'MAIL': '/var/mail/cltbld', 18:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:59 INFO - 'MOZ_NO_REMOTE': '1', 18:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:59 INFO - 'NO_EM_RESTART': '1', 18:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:59 INFO - 'PWD': '/builds/slave/test', 18:54:59 INFO - 'SHELL': '/bin/bash', 18:54:59 INFO - 'SHLVL': '1', 18:54:59 INFO - 'TERM': 'linux', 18:54:59 INFO - 'TMOUT': '86400', 18:54:59 INFO - 'USER': 'cltbld', 18:54:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:59 INFO - '_': '/tools/buildbot/bin/python'} 18:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:00 INFO - Running setup.py (path:/tmp/pip-tbY6Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:00 INFO - Running setup.py (path:/tmp/pip-tmHRDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:00 INFO - Running setup.py (path:/tmp/pip-lZwhtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:00 INFO - Running setup.py (path:/tmp/pip-gfeUCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:00 INFO - Running setup.py (path:/tmp/pip-LE4sDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:00 INFO - Running setup.py (path:/tmp/pip-E1ng_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:00 INFO - Running setup.py (path:/tmp/pip-BKq9cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:00 INFO - Running setup.py (path:/tmp/pip-NsLMhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:00 INFO - Running setup.py (path:/tmp/pip-_j8taB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:00 INFO - Running setup.py (path:/tmp/pip-Mx6S7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:00 INFO - Running setup.py (path:/tmp/pip-1tk1xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:00 INFO - Running setup.py (path:/tmp/pip-_Bzk_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:00 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)) 18:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:01 INFO - Running setup.py (path:/tmp/pip-JLYcVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:01 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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:01 INFO - Running setup.py (path:/tmp/pip-UlBaQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:01 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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:01 INFO - Running setup.py (path:/tmp/pip-k3D4Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:01 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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:01 INFO - Running setup.py (path:/tmp/pip-UK3AH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:01 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)) 18:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:01 INFO - Running setup.py (path:/tmp/pip-q3UQFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:01 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)) 18:55:01 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)) 18:55:01 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)) 18:55:01 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)) 18:55:01 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)) 18:55:01 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)) 18:55:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:03 INFO - Downloading blessings-1.6.tar.gz 18:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:55:03 INFO - Installing collected packages: blessings 18:55:03 INFO - Running setup.py install for blessings 18:55:03 INFO - Successfully installed blessings 18:55:03 INFO - Cleaning up... 18:55:03 INFO - Return code: 0 18:55:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:03 INFO - Reading from file tmpfile_stdout 18:55:03 INFO - Current package versions: 18:55:03 INFO - argparse == 1.2.1 18:55:03 INFO - blessings == 1.6 18:55:03 INFO - blobuploader == 1.2.4 18:55:03 INFO - docopt == 0.6.1 18:55:03 INFO - functools32 == 3.2.3-2 18:55:03 INFO - jsonschema == 2.5.1 18:55:03 INFO - manifestparser == 1.1 18:55:03 INFO - mozInstall == 1.12 18:55:03 INFO - mozcrash == 1.0 18:55:03 INFO - mozdebug == 0.1 18:55:03 INFO - mozdevice == 0.48 18:55:03 INFO - mozfile == 1.2 18:55:03 INFO - mozhttpd == 0.7 18:55:03 INFO - mozinfo == 0.9 18:55:03 INFO - mozleak == 0.1 18:55:03 INFO - mozlog == 3.4 18:55:03 INFO - moznetwork == 0.27 18:55:03 INFO - mozprocess == 0.23 18:55:03 INFO - mozprofile == 0.28 18:55:03 INFO - mozrunner == 6.13 18:55:03 INFO - mozscreenshot == 0.1 18:55:03 INFO - mozsystemmonitor == 0.3 18:55:03 INFO - moztest == 0.8 18:55:03 INFO - mozversion == 1.4 18:55:03 INFO - psutil == 3.1.1 18:55:03 INFO - requests == 1.2.3 18:55:03 INFO - wsgiref == 0.1.2 18:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:03 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 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:55:03 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 18:55:03 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 18:55:03 INFO - Using env: {'DISPLAY': ':0', 18:55:03 INFO - 'HOME': '/home/cltbld', 18:55:03 INFO - 'LANG': 'en_US.UTF-8', 18:55:03 INFO - 'LANGUAGE': 'en_US:en', 18:55:03 INFO - 'LOGNAME': 'cltbld', 18:55:03 INFO - 'MAIL': '/var/mail/cltbld', 18:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:03 INFO - 'MOZ_NO_REMOTE': '1', 18:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:03 INFO - 'NO_EM_RESTART': '1', 18:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:03 INFO - 'PWD': '/builds/slave/test', 18:55:03 INFO - 'SHELL': '/bin/bash', 18:55:03 INFO - 'SHLVL': '1', 18:55:03 INFO - 'TERM': 'linux', 18:55:03 INFO - 'TMOUT': '86400', 18:55:03 INFO - 'USER': 'cltbld', 18:55:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:03 INFO - '_': '/tools/buildbot/bin/python'} 18:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 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)) 18:55:04 INFO - Cleaning up... 18:55:04 INFO - Return code: 0 18:55:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ad436ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe738e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', '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 18:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:55:04 INFO - Using env: {'DISPLAY': ':0', 18:55:04 INFO - 'HOME': '/home/cltbld', 18:55:04 INFO - 'LANG': 'en_US.UTF-8', 18:55:04 INFO - 'LANGUAGE': 'en_US:en', 18:55:04 INFO - 'LOGNAME': 'cltbld', 18:55:04 INFO - 'MAIL': '/var/mail/cltbld', 18:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:04 INFO - 'MOZ_NO_REMOTE': '1', 18:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:04 INFO - 'NO_EM_RESTART': '1', 18:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:04 INFO - 'PWD': '/builds/slave/test', 18:55:04 INFO - 'SHELL': '/bin/bash', 18:55:04 INFO - 'SHLVL': '1', 18:55:04 INFO - 'TERM': 'linux', 18:55:04 INFO - 'TMOUT': '86400', 18:55:04 INFO - 'USER': 'cltbld', 18:55:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:04 INFO - '_': '/tools/buildbot/bin/python'} 18:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:55:04 INFO - Cleaning up... 18:55:04 INFO - Return code: 0 18:55:04 INFO - Running post-action listener: _resource_record_post_action 18:55:04 INFO - Running post-action listener: _start_resource_monitoring 18:55:04 INFO - Starting resource monitoring. 18:55:04 INFO - [mozharness: 2017-01-13 02:55:04.352441Z] Finished create-virtualenv step (success) 18:55:04 INFO - [mozharness: 2017-01-13 02:55:04.352901Z] Running install step. 18:55:04 INFO - Running pre-action listener: _resource_record_pre_action 18:55:04 INFO - Running main action method: install 18:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:04 INFO - Reading from file tmpfile_stdout 18:55:04 INFO - Detecting whether we're running mozinstall >=1.0... 18:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:55:04 INFO - Reading from file tmpfile_stdout 18:55:04 INFO - Output received: 18:55:04 INFO - Usage: mozinstall [options] installer 18:55:04 INFO - Options: 18:55:04 INFO - -h, --help show this help message and exit 18:55:04 INFO - -d DEST, --destination=DEST 18:55:04 INFO - Directory to install application into. [default: 18:55:04 INFO - "/builds/slave/test"] 18:55:04 INFO - --app=APP Application being installed. [default: firefox] 18:55:04 INFO - mkdir: /builds/slave/test/build/application 18:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:55:20 INFO - Reading from file tmpfile_stdout 18:55:20 INFO - Output received: 18:55:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:55:20 INFO - Running post-action listener: _resource_record_post_action 18:55:20 INFO - [mozharness: 2017-01-13 02:55:20.605137Z] Finished install step (success) 18:55:20 INFO - [mozharness: 2017-01-13 02:55:20.605377Z] Running run-tests step. 18:55:20 INFO - Running pre-action listener: _resource_record_pre_action 18:55:20 INFO - Running main action method: run_tests 18:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:55:20 INFO - Python 2.7.3 18:55:20 INFO - Return code: 0 18:55:20 INFO - grabbing minidump binary from tooltool 18:55:20 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')]} 18:55:20 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 0xf0c100>, '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 0xf039d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03e60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:55:20 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 18:55:20 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 18:55:20 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 18:55:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:55:20 INFO - Return code: 0 18:55:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:55:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:55:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:55:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:55:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 18:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 18:55:20 INFO - Using env: {'DISPLAY': ':0', 18:55:20 INFO - 'HOME': '/home/cltbld', 18:55:20 INFO - 'LANG': 'en_US.UTF-8', 18:55:20 INFO - 'LANGUAGE': 'en_US:en', 18:55:20 INFO - 'LOGNAME': 'cltbld', 18:55:20 INFO - 'MAIL': '/var/mail/cltbld', 18:55:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:55:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:20 INFO - 'MOZ_NO_REMOTE': '1', 18:55:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:20 INFO - 'NO_EM_RESTART': '1', 18:55:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:20 INFO - 'PWD': '/builds/slave/test', 18:55:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:55:20 INFO - 'SHELL': '/bin/bash', 18:55:20 INFO - 'SHLVL': '1', 18:55:20 INFO - 'TERM': 'linux', 18:55:20 INFO - 'TMOUT': '86400', 18:55:20 INFO - 'USER': 'cltbld', 18:55:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063', 18:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:20 INFO - '_': '/tools/buildbot/bin/python'} 18:55:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 18:55:20 INFO - mozversion application_buildid: 20170112171016 18:55:20 INFO - mozversion application_changeset: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 18:55:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:55:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:55:20 INFO - mozversion application_name: Firefox 18:55:20 INFO - mozversion application_remotingname: firefox-dev 18:55:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:55:20 INFO - mozversion application_vendor: Mozilla 18:55:20 INFO - mozversion application_version: 52.0a2 18:55:20 INFO - mozversion platform_buildid: 20170112171016 18:55:20 INFO - mozversion platform_changeset: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 18:55:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:55:20 INFO - mozversion platform_version: 52.0a2 18:55:20 INFO - using testdate: 1484276120 18:55:20 INFO - actual date: 1484276120 18:55:20 INFO - starting webserver on 'localhost:53231' 18:55:20 INFO - SUITE-START | Running 2 tests 18:55:20 INFO - TEST-START | dromaeo_css 18:55:20 INFO - operating with platform_type : linux_ 18:55:20 INFO - Initialising browser for dromaeo_css test... 18:55:20 INFO - TEST-INFO | started process 8793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KxbZa/profile http://localhost:53231/getInfo.html) 18:55:25 INFO - PROCESS | 8793 | __metrics Screen width/height:1600/1200 18:55:25 INFO - PROCESS | 8793 | colorDepth:24 18:55:25 INFO - PROCESS | 8793 | Browser inner width/height: 1024/697 18:55:25 INFO - PROCESS | 8793 | __metrics 18:55:25 INFO - PROCESS | 8793 | 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" 18:55:25 INFO - PROCESS | 8793 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:55:26 INFO - PROCESS | 8793 | console.error: PushService: 18:55:26 INFO - PROCESS | 8793 | stateChangeProcessEnqueue: Error transitioning state 18:55:26 INFO - PROCESS | 8793 | UnknownError 18:55:26 INFO - TEST-INFO | 8793: exit 0 18:55:26 INFO - Browser initialized. 18:55:26 INFO - Running cycle 1/1 for dromaeo_css test... 18:55:26 INFO - TEST-INFO | started process 8885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7KxbZa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:38 INFO - PROCESS | 8885 | RSS: Main: 147173376 18:55:38 INFO - PROCESS | 8885 | 18:58:40 INFO - PROCESS | 8885 | Cycle 1(1): loaded http://localhost:53231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53231/tests/dromaeo/cssquery-ext.html) 18:58:41 INFO - PROCESS | 8885 | RSS: Main: 243220480 18:58:41 INFO - PROCESS | 8885 | 19:01:43 INFO - PROCESS | 8885 | Cycle 1(1): loaded http://localhost:53231/tests/dromaeo/cssquery-ext.html (next: http://localhost:53231/tests/dromaeo/cssquery-jquery.html) 19:01:44 INFO - PROCESS | 8885 | RSS: Main: 238338048 19:01:44 INFO - PROCESS | 8885 | 19:04:46 INFO - PROCESS | 8885 | Cycle 1(1): loaded http://localhost:53231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53231/tests/dromaeo/cssquery-mootools.html) 19:04:46 INFO - PROCESS | 8885 | RSS: Main: 175009792 19:04:46 INFO - PROCESS | 8885 | 19:07:48 INFO - PROCESS | 8885 | Cycle 1(1): loaded http://localhost:53231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53231/tests/dromaeo/cssquery-prototype.html) 19:07:49 INFO - PROCESS | 8885 | RSS: Main: 214511616 19:07:49 INFO - PROCESS | 8885 | 19:10:52 INFO - PROCESS | 8885 | Cycle 1(1): loaded http://localhost:53231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53231/tests/dromaeo/cssquery-yui.html) 19:10:52 INFO - PROCESS | 8885 | RSS: Main: 176873472 19:10:52 INFO - PROCESS | 8885 | 19:13:54 INFO - PROCESS | 8885 | Cycle 1(1): loaded http://localhost:53231/tests/dromaeo/cssquery-yui.html (next: http://localhost:53231/tests/dromaeo/cssquery-dojo.html) 19:13:55 INFO - PROCESS | 8885 | RSS: Main: 268312576 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | __start_tp_report 19:13:55 INFO - PROCESS | 8885 | _x_x_mozilla_page_load 19:13:55 INFO - PROCESS | 8885 | _x_x_mozilla_page_load_details 19:13:55 INFO - PROCESS | 8885 | |i|pagename|runs| 19:13:55 INFO - PROCESS | 8885 | |0;dojo.html;3207.3424947885687;3247.561579186809;3257.2345498807776;3260.7717459777796;3286.0963235110344;5459.918101228484;5528.944710552893;5540.196671482643;5540.252065971088;5543.944560554403;5555.694436805974;5587.8603034924145;5593.161025846125;5594.328680558328;5600;5026.572741316983;5054.292399064116;5083.491650834924;5096.108181068298;5154.304168937202;4915.115279249733;4931.605471562267;5116.079105760961;5164.664296820694;5172.172452407615;4939.160342741725;4959.628027897922;4971.6271279654175;5009.9749501252445;5031.094403007457;5027;5058.367704036977;5128.102582048164;5129.230615407681;5159.14874045782;4833.178359678828;5035.370578677665;5049.419316778581;5072.67027643202;5106.591472682177;5330.173823057432;5337.279467271907;5367.382750983609;5390;5437.782488700447;5804.361520232771;5808.157817116495;5907.911381329283;5910.113482977545;5912.556558258105;5750.683712395817;5929.614575052651;5943.3462319144855;5946.375630558772;5954.642721436728;5359.008583412081;5552.555795536347;5569.721513924287;5582.525485333711;5670.943290567124;6121.663308517986;6163.044728067157;6168.136460895478;6168.753249870045;6171.7531298748445;5692.1461780733225;5927.525797936155;5927.525797936155;5933.762649493972;5934.851628709317;5805.564582656318;5852.795152169739;5878.147668588031;5882;5963.135345374896;5889.646621202742;5897.292324921037;5900.6164599301765;5900.675462849585;5902;5833.766649333979;5897.734601942923;5899.46904778572;5901.793437229762;5916.970415147896;4461.308497182942;4486.057927835126;4541.091781643684;4560.771961401917;4561.384213131251;4074.5162885732866;4089.3661482470266;4105.035316700573;4116.91766164681;4123.484564429446;5674.06377947634;5681;5681.715914204273;5685.715714214355;5717.799877004368;5759.798407055733;5804.796832110856;5859.296884373817;5933;5960.523158147338;5675.602707810413;5679.517241034476;5679.716014199274;5707.514861236758;5729.656220626693;5096.821611243663;5100.030994111107;5105.132127538327;5110.28456016158;5135.537801597874;5753.798617048383;5867.295924489089;5931.733072011683;5975.073863551156;5997.160397544348;5850.619709718854;5937.643741375531;5945.137954996588;5960.225170727777;5974.1636170935235;5930.05119180929;6013.218281623361;6013.819585412444;6022.488088512526;6023.096535519707;5693.772249109989;5789.91315130265;5809.796657116981;5812.476877081083;5815.79644712433;5783.16144159103;5845.035569131216;5880.411958804086;5890.14592884038;5965.075413310944;5757.366689664217;5794;5799.797007104731;5802.564807639528;5816.47651711348;5776.508996735324;5781.4218578141845;5787;5787.797427090031;5790.826275211751;5497.670139791625;5613.382527921844;5661.433856614306;5688.146777983336;5697.4302569742695;5819.388964158702;5821.446962538552;5828.329742079545;5829.067349224104;5830.47525722687;5600.075987462186;5637.041702910433;5665.3201615806365;5687.658740475585;5691 19:13:55 INFO - PROCESS | 8885 | |1;ext.html;589.5489950188107;608.7412849538946;641.3009819296965;665.733706517393;681.9693113809878;33633.327333453315;45646.54353456465;46471.76764116183;46517.53482465178;46568.068638627294;45649.0870182597;46061.53938460623;46204;46218.76890615542;46229.30656040162;8367.703006034075;8959.552022398886;9108.453492790453;9109.498977556264;9111.544422778868;8375.371847111492;10549.683509494727;10801.40592267425;10811.675649730481;11094.722631934186;11021.283616564897;11060.336379817196;11085.556577736921;11088.390138542378;11089.889101109007;10819;10864.239503234738;10868.782624347468;10873.782524349548;10888.128949684085;10718.839217411667;10796.838047429295;10800.297980631234;10800.5679772809;10801.621943232029;43854.34218486693;44166.33750493745;44315.55684443179;44376.33435498438;44404.333934991;3665.120371110914;3722.236941427001;3727.0682329417646;3777.263433630443;4096.365063415175;30850;33359.83320083384;33778;33805.661943380495;34482;4155.2728272552185;4167.83328666853;4170.145120250341;4214.494260688706;4256.914861702749;343880;349664;350339.2483037594;350770.99999999744;352537;66968.33031669621;67714.32285677179;67872.6606366965;67929;67975;41618.37572436416;42177;42423;44563;71940;18195;18363.357282495315;18378.448646540626;18380;18386.448406547825;12724.554640587536;12953.611391658265;13210.867891321155;13400.994925380635;13538.187708737507;21184.881511849;22207.66688499674;22373.888130559244;22381.664275035888;22400.215992440186;7593.506422082547;7697.384209263246;7727.304542591194;7781.727639532589;7800.92199078002;988.5502096546054;1026.7587117027492;1038.714353552764;1039.111559616517;1052.4948024947914;33484.665153348156;34202.31595368079;34261;34432.96701098971;34685.826570866986;1144.0275765599174;1154.6709187881413;1194.623698483708;1198.1373411143963;1219.5609580550995;17267.74098388525;17961.461156165336;18214;18231.088445577934;18306.725399119023;510212;514466;516510;516625;516925.1537423189;62873.68563157155;62897.685511573065;63098.36901631017;63248.683756580926;63562.68218658877;1220.1702842067302;1220.664317312746;1330.4079684540286;1367.924764137962;1378.9724205516034;30598.235044123183;34161;34948;35096.824515877255;35296.29407411889;53336.46663533315;53778;54013.72993135009;54031.459685402646;54130.18804718011;399514;399701;402928;403956;509980;45972.770136149105;46688.766556167;46726;46773.766131169126;47561.5243847571;49418.75290623524;49998.25002625036;50494.74752626213;50748.49251507438;51056.48943510517;42193.78903105465;42494.36258456064;43264.13471730611;43443.782781085894;47398.52601474079;42536.78731606322;42937;43260.783696081315;44127.558724413626;44448;43195.136097278504;43234.56765432431;43915.78042109769;44314.778426108955;44458.9993450302;36066.4590031155;38628.6137138625;38701.41947870728;38900.6109938897;39363.01592460097;29375;29846.10461686153;29920.700792991793;29952.550711739776;30154 19:13:55 INFO - PROCESS | 8885 | |2;jquery.html;398.5841339718611;401.87742738464794;408.48938826466923;418.7843260720728;423.419914716838;14639.853601463983;16366.672666546661;19356.3225287115;19975.800241997575;20112;19726.901365493188;20097;20247.59504809903;20282;20549.897250513764;5560.527355174815;5569;5699.686517241571;5761.740721667514;5767.884642307151;4320.935185972197;5571.1086226203815;5653.23681303025;5669.262995810539;5671;4542.227821270376;6029.397060293957;6308.684565771716;6319.968400157993;6420.93579064208;6128.662923539226;6329.68351582419;6375.6174629522375;6409;6409.102725618417;5655.632383895034;5656.943430565683;5657.377688454267;5666.575006874501;5712.428757124296;24175.879120604284;24302;24444.266671999692;24471.510569788683;24559.263222103367;2413.7706917842775;2519.1560827122935;2528.6645178672984;2692.4211294571564;2809.2134202423354;14730.926345368205;14894.255287235595;15132.092074475566;15243.39026438941;15581.844181558266;1908.9045547722696;1962.9901850490655;2025.9594808103902;2043.5042905607722;2079.625667379871;78576;92946.07053929442;93154.5342273291;94133.52933235359;95343.52328238385;10487;11560.190786645022;12127.09046821492;12179.330136842558;12188.268703877795;16766.329346826235;16768.07775572331;16778.6644267114;16783.1608419581;16802.663946720997;7968.482048666818;8208.302294305051;8458.492490450593;8477;8498.150184981576;7691.46159768822;7762.573058481725;7874.330681892104;7909.446338756347;8121.715739949192;4638.95361046392;4923.532264434873;4924.852254432372;5112.156494178494;5130.7947682093045;1856.3595559531939;1927.9614407711767;1934.429343343717;2017.3544465770813;2048.723422337995;837.1419295222446;876.202655583416;895.10684901433;991.0733464210986;1043.4487677628126;18394.908025459787;19396.295426495384;19408;19449.31927382535;19486.317978870673;986.3194395866828;1010.1211945607222;1012.7569383348091;1074.6023971130733;1078.5577913055608;10217.438040907673;11000.702999965086;11052.281601695864;11054.944725276322;11082.722931926766;523499;523576;532835;540252;550999;98534.50732746434;99341;102331;104712;107835;1015.5227043289642;1069.096613361708;1069.4332004037717;1073.7369344510646;1091.1161958813386;16789.748153777946;17053.65892682164;17180.91409542944;17671.38150164738;17973;40805;43832.342514861666;43919.56080439155;44596.33105503485;45382.77308613436;56733.71633141808;62530.37469625427;62706;64206.35793642004;64305;8116.2695357418115;8317.41778075529;8369.995600527976;8409.53747543891;9202.401843880127;11833;13305.667358315732;13348.799768003293;13369;13830.930845345709;11795.233309834834;11816.82274765862;12124.265993484521;12434.56479023266;12449.502019919102;11646.242994205688;11687.298762074302;11827.763444731228;11909.94045029804;12262.877371226174;11971.76056478883;12070.758584828078;12142.878571214174;12417.813732793835;12615.30615816139;8080.9191908080165;8235.176482351717;8695.608712601963;11445.942770286096;12483.75032499363;12375.443105060114;12778.488860445477;13052.738945220852;13076.934615326862;13150.671233219246 19:13:55 INFO - PROCESS | 8885 | |3;mootools.html;1451.5282533176714;1490.128274959149;1577.3611687266662;1715.1338574020126;1726.1628110366478;7719.4982326148765;8188.385871059672;8262.669493220279;8264.421490495668;8271.462354946923;7532.849343013137;7764.805879853006;8168.387370947173;8230.91769082309;8360.289375403083;2299.1952816514254;2319;2324.2097686786487;2333.88330583471;2335.439494521311;2379.881005949704;2383.0586918167314;2420.092465325503;2433.3794882304987;2439.0609615298063;2391.0674836813655;2393.44950661348;2411.9758802411925;2413.8793060347;2414.022320960014;2273.545290941802;2279.122537822942;2296.9770302297015;2299.390661474719;2307.2847417300522;2330.0912644068826;2333.9533209335887;2351.8941647625898;2354;2357.0689577616918;8501.82996340076;8575;8589.184027517376;8593.097724738875;8598.5700714964;4941.678790878617;5119.56483698886;5121.6670916390685;5125.359330083739;5128.461511541309;3165.335279591289;3185.9681403185905;3214.164317277501;3240.902772916816;3363.243270264171;1056.8995945385177;1076.8976947190004;1088.7495875948575;1094.5129417409255;1097.0729733375285;11051.17116216287;11103.111751059976;11117.777644447066;11136.33182009082;11147.609833655782;4344.456942882077;4469.061497085649;4512.435945506812;4533.84131555394;4644.489106198315;9926.255530835217;9941.204703623693;9944.055314745088;9963.103320701171;9980.600775969026;5235.712035837989;5239.47605239473;5242.659227150223;5246.632735708464;5252.264682944391;4259.829606815692;4285.035866929916;4760.666753327303;4771.785269662804;4840.854774356775;3980.960190398117;4057.655099316591;4108.897277568085;4117.3206420940805;4146.212219678251;1315.4540865540885;1316.8288122544009;1322.8478724946563;1330.1287656584952;1331.1414137881206;991.1624677147798;996.4071377530358;998.5556427389741;1004.4927311707687;1020.7193021919031;6071.696415179224;6110.327863934964;6128.846778830476;6194.938050619527;6209.9068513972325;446.4174252600323;456.1128604863509;467.4647528579757;475.4698511160101;476.7640018191018;4189.120284740238;4234.449521562177;4296.849610263625;4307.6338511226895;4341.066670665822;10096.192304615613;10117.696469105938;10219.795604087876;10344.224183186141;10433.895661043292;10285.22860785444;10303.227257955683;10304.536295866705;10308.278420510493;10316.793664126675;7893.565853878092;7972.60136993148;8020.11778704342;8040.316573091236;8044.919550804417;5949.494292985145;5960.284765828128;6000.159977603052;6003.249593800775;6157;9391.906080939103;9412.482313472825;9467.384619999679;9517.524123793644;9522.381045232038;9503.572339244889;9608;9634.71095867125;9656.806863862543;9710;6927.480438966997;7111.928880711127;7131.928680713127;7341.559506429631;7428.145763237297;7788.493747906368;8103.189681031849;8104.594770261346;8108.351331893552;8115.391345648982;7110.786676399716;7163.820904477429;7203.459740519377;7241.239669834592;7340.1191856975365;7202.135743710788;7262.273772622695;7280.0535930328715;7292.088488938883;7321.231270716498;6795.048693183057;6908.205556361083;6909.1018167639895;6909.136357955255;6910.516263861481;4893.853184404474;5064.772085256246;5064.949350506595;5181.093308671043;5313.893722125613;4807.206810876166;4919.704817710949;4957.628177886745;5022.17134172872;5094.2867998479505 19:13:55 INFO - PROCESS | 8885 | |4;prototype.html;317.7892230601407;327.8770461077096;328.6828210776601;332.9766916315857;335.03676928829617;5239.738013099349;5389.83830485086;5402.783888644454;5456.508914197717;5499.257600223968;5175.870603234921;5319.627626066167;5347.112559218018;5354.14333706607;5382.2195781611645;4175.164967006595;4191.622753952143;4193.490343476361;4207.20063187994;4222.37438586145;4112.773797441139;4183.330667093266;4190.141021090669;4227.87316380509;4236.131593023439;4136.738294820078;4165.604267594589;4165.854195103172;4171.124063946575;4173.311403618414;4159.646430053464;4166.312558427856;4178.26880295947;4179.26862799009;4207.621314081747;3735.533058367704;3741.719371047155;3748.9437658435145;3749.4000959846567;3753.4369844523267;5058.570021548173;5226.320578324831;5228.660137091077;5240.737963101829;5241.711705856176;4764.356811830393;4780.211265141283;4791;4791.976040119777;4833.202521583935;5512.145617429305;5659.886802263973;5661.2923384576925;5664.291963504562;5674.460926212003;4038.757674539537;4049.230646177217;4059.289624315733;4069.837206511736;4086.5504794472586;5775.5957083004205;5831.271091113611;5839.649621022752;5844.736986835603;5845.824625261206;4155.688323375698;4165.645920096765;4183.435236243129;4191.64371028466;4205.915881682349;4053.1691003344245;4167.187398457332;4192.993681516414;4194.643455306333;4196;4740.905181896343;4745.572898439157;4746.620270378361;4754.096721622881;4761.238201887751;5623.493885550321;5625.184348269559;5625.549956003591;5638.464345887134;5650.26546548946;1331.2944139605831;1342.2617560341773;1372.6980064385818;1401.5563969111831;1401.7897315402568;952.2810278239884;959.5538074795114;967.4582233949011;970.1365784451843;976.5800705696619;5299.3905700844125;5302.787888484418;5303.753617899791;5304.230886521433;5331.333583302087;5536.529395001389;5568.106843673089;5570.3315602128005;5575.581831362664;5605.859853503695;5189.558887494605;5289.444608316148;5293.814716484904;5324.361076670747;5495.862603434946;2950.8967186148384;2973.9702602973694;2991.5811786349927;2999.1602351341658;2999.2801727585224;5677.886442271214;5711.600187986801;5718.285214348207;5720.367566595159;5732.914006289909;5571.693556854412;5657.688827114548;5693.572982026365;5706.089894154012;5706.885862282731;5689.743961521742;5704.857378565486;5722.885542289131;5734.283214598176;5780.768769249351;5426.647267927572;5648.435156484319;5681.125228674445;5691.658500489983;5713.257276554022;5507.807226747044;5535.501804837584;5579.888402231852;5611.382747897646;5642.463965923231;5709.343425505954;5716.28546431696;5716.42835716425;5720.513756330759;5746.310442746897;3869.7871617061332;3974.6224108709625;3983.143624120828;4003.7197396181987;4023.637872591481;5615.971920140373;5671.092625179951;5686.943130568641;5687.60186786921;5705.4579814917515;5537.612367134423;5627.915581266202;5696.772129114789;5701.116326969326;5709.51469125129;5603.943960560342;5677.914831277451;5692.459216374438;5695.772169113189;5709;5505.834824955257;5603.523700485504;5645.096784514458;5653.208550802973;5657.349404818498;5687.374388817144;5693.345265294379;5700.144978253295;5702.287214098238;5725.8568535786935;5404.486573775485;5556.416576259435;5594.021046316797;5617.185508101385;5628.1557766333735 19:13:55 INFO - PROCESS | 8885 | |5;yui.html;761.4593638516653;801.4990630855715;818.3207937411947;821.5768879027298;856.7601071699922;15101.169435681033;15891.761623575656;16030.839691603094;16059.700298901364;16065.036097834109;14433.711325773478;14539.636509087279;14586.343614537345;14599.27003649816;14603.269836508185;703.820525765929;716.3910675925474;809.0776514773163;834.2991886815074;843.4306842881061;853.6884037326394;856.8115014696757;856.8500512410335;857.6740838481369;858.1418581418582;904.1230006893336;904.2404380320529;905.307439808547;906.1572737354257;907.0702529906865;726.9055022847023;748.0462410426695;855.7475544714324;878.4729162502512;899.9595018224196;653.4804830160034;653.6045692356151;653.7744478155076;653.8267359149829;654.1594051643663;14757.18835464049;14763.852361476354;14825.406983720639;14829.25853707321;14875.181864997421;13001.284929328884;13061.86938130616;13393.531226407029;13418.060735748502;13790;12832.101752877303;12867.935660321733;12893;12896.484140634364;13189.86810131896;4218.156368726267;4221.5567365426805;4226.598473145046;4241.2365774160635;4276.655507715651;63332;63603.6819815898;63608;63965.680171599306;64763;10720.303180293256;10728.356298622108;10992;11087.667369978913;11211.71970700739;20902.89548552278;21126.577468450545;21325;21403.46491337729;21550.676739848914;8283.29591984676;8343.666253349798;8365.916340836635;8575.785605359915;8620.396572239883;4315.244832154423;4444.377787109807;4490.573395527485;4509.210888094571;4559.589636932692;3260.3316320154313;3364.4280472319765;3369.848356823949;3371.4268574342423;3387.305602351512;576.3199424678835;580.3152280309191;591.0985746736176;591.8490784849836;600.4835841176584;626.8495561065403;647.7052940911874;704.9259827718118;713.1905287498727;738.5310327941795;9249.445033298023;9356.111169438893;9495.335326527076;9607.951960240294;9673.516324183762;669.1568623534382;670.1957650819037;682.8429461223947;706.2421245038134;737.6643627149741;4496.505384407713;4549.112922980054;4549.909001819945;4557.5898169164275;4669.533046695304;86173.56913215393;86398.56800715956;87118.12881871227;91065.54467227621;94352;47795.761021194674;48356.03287934292;49301;75102.87345689819;75698;69597.30402695909;70252.2974770256;71050.64474677698;72587;73171;9063.456192628464;9230.769230769016;9231.86152207704;9259.72220833376;9300.162985331353;48427.75786121047;49322.753386234275;50287.49712502828;50465.74767126141;50658;63738;66758.66620666865;68588.65705671639;68694.31305686879;71432;11127;11228.101751859995;11245;11471.713207169887;11700.70748231301;12091.697707557381;12113.818292725793;12161.148719589544;12222.75554488923;12289;10958.563769261016;13074.28091454979;13138;13181.209127452;13239.073264871367;13141.671458213621;13462.596122116352;13549;13680.31598420095;13867.583972480841;12943;13154.671133221746;13370.331483425984;13681.726365472436;14159.858401415853;11449.656510304705;11606.94196529012;11628.94185529067;11785.941070294593;12108.304837322958;9964.900350996397;10753.354798712102;11434.94282528582;11528.135389845962;11581.652550423501 19:13:55 INFO - PROCESS | 8885 | __end_tp_report 19:13:55 INFO - PROCESS | 8885 | __start_cc_report 19:13:55 INFO - PROCESS | 8885 | _x_x_mozilla_cycle_collect,931 19:13:55 INFO - PROCESS | 8885 | __end_cc_report 19:13:55 INFO - PROCESS | 8885 | __startTimestamp1484277235217__endTimestamp 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | ------- Summary: start ------- 19:13:55 INFO - PROCESS | 8885 | Number of tests: 6 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | [#0] dojo.html Cycles:165 Average:5490.09 Median:5693.77 stddev:603.29 (10.6%) stddev-sans-first:577.95 19:13:55 INFO - PROCESS | 8885 | Values: 3207.3 3247.6 3257.2 3260.8 3286.1 5459.9 5528.9 5540.2 5540.3 5543.9 5555.7 5587.9 5593.2 5594.3 5600.0 5026.6 5054.3 5083.5 5096.1 5154.3 4915.1 4931.6 5116.1 5164.7 5172.2 4939.2 4959.6 4971.6 5010.0 5031.1 5027.0 5058.4 5128.1 5129.2 5159.1 4833.2 5035.4 5049.4 5072.7 5106.6 5330.2 5337.3 5367.4 5390.0 5437.8 5804.4 5808.2 5907.9 5910.1 5912.6 5750.7 5929.6 5943.3 5946.4 5954.6 5359.0 5552.6 5569.7 5582.5 5670.9 6121.7 6163.0 6168.1 6168.8 6171.8 5692.1 5927.5 5927.5 5933.8 5934.9 5805.6 5852.8 5878.1 5882.0 5963.1 5889.6 5897.3 5900.6 5900.7 5902.0 5833.8 5897.7 5899.5 5901.8 5917.0 4461.3 4486.1 4541.1 4560.8 4561.4 4074.5 4089.4 4105.0 4116.9 4123.5 5674.1 5681.0 5681.7 5685.7 5717.8 5759.8 5804.8 5859.3 5933.0 5960.5 5675.6 5679.5 5679.7 5707.5 5729.7 5096.8 5100.0 5105.1 5110.3 5135.5 5753.8 5867.3 5931.7 5975.1 5997.2 5850.6 5937.6 5945.1 5960.2 5974.2 5930.1 6013.2 6013.8 6022.5 6023.1 5693.8 5789.9 5809.8 5812.5 5815.8 5783.2 5845.0 5880.4 5890.1 5965.1 5757.4 5794.0 5799.8 5802.6 5816.5 5776.5 5781.4 5787.0 5787.8 5790.8 5497.7 5613.4 5661.4 5688.1 5697.4 5819.4 5821.4 5828.3 5829.1 5830.5 5600.1 5637.0 5665.3 5687.7 5691.0 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | [#1] ext.html Cycles:180 Average:61004.08 Median:403442.00 stddev:114885.41 (28.5%) stddev-sans-first:115118.15 19:13:55 INFO - PROCESS | 8885 | Values: 589.5 608.7 641.3 665.7 682.0 33633.3 45646.5 46471.8 46517.5 46568.1 45649.1 46061.5 46204.0 46218.8 46229.3 8367.7 8959.6 9108.5 9109.5 9111.5 8375.4 10549.7 10801.4 10811.7 11094.7 11021.3 11060.3 11085.6 11088.4 11089.9 10819.0 10864.2 10868.8 10873.8 10888.1 10718.8 10796.8 10800.3 10800.6 10801.6 43854.3 44166.3 44315.6 44376.3 44404.3 3665.1 3722.2 3727.1 3777.3 4096.4 30850.0 33359.8 33778.0 33805.7 34482.0 4155.3 4167.8 4170.1 4214.5 4256.9 343880.0 349664.0 350339.2 350771.0 352537.0 66968.3 67714.3 67872.7 67929.0 67975.0 41618.4 42177.0 42423.0 44563.0 71940.0 18195.0 18363.4 18378.4 18380.0 18386.4 12724.6 12953.6 13210.9 13401.0 13538.2 21184.9 22207.7 22373.9 22381.7 22400.2 7593.5 7697.4 7727.3 7781.7 7800.9 988.6 1026.8 1038.7 1039.1 1052.5 33484.7 34202.3 34261.0 34433.0 34685.8 1144.0 1154.7 1194.6 1198.1 1219.6 17267.7 17961.5 18214.0 18231.1 18306.7 510212.0 514466.0 516510.0 516625.0 516925.2 62873.7 62897.7 63098.4 63248.7 63562.7 1220.2 1220.7 1330.4 1367.9 1379.0 30598.2 34161.0 34948.0 35096.8 35296.3 53336.5 53778.0 54013.7 54031.5 54130.2 399514.0 399701.0 402928.0 403956.0 509980.0 45972.8 46688.8 46726.0 46773.8 47561.5 49418.8 49998.3 50494.7 50748.5 51056.5 42193.8 42494.4 43264.1 43443.8 47398.5 42536.8 42937.0 43260.8 44127.6 44448.0 43195.1 43234.6 43915.8 44314.8 44459.0 36066.5 38628.6 38701.4 38900.6 39363.0 29375.0 29846.1 29920.7 29952.6 30154.0 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | [#2] jquery.html Cycles:180 Average:31326.61 Median:13294.82 stddev:88254.38 (663.8%) stddev-sans-first:88471.41 19:13:55 INFO - PROCESS | 8885 | Values: 398.6 401.9 408.5 418.8 423.4 14639.9 16366.7 19356.3 19975.8 20112.0 19726.9 20097.0 20247.6 20282.0 20549.9 5560.5 5569.0 5699.7 5761.7 5767.9 4320.9 5571.1 5653.2 5669.3 5671.0 4542.2 6029.4 6308.7 6320.0 6420.9 6128.7 6329.7 6375.6 6409.0 6409.1 5655.6 5656.9 5657.4 5666.6 5712.4 24175.9 24302.0 24444.3 24471.5 24559.3 2413.8 2519.2 2528.7 2692.4 2809.2 14730.9 14894.3 15132.1 15243.4 15581.8 1908.9 1963.0 2026.0 2043.5 2079.6 78576.0 92946.1 93154.5 94133.5 95343.5 10487.0 11560.2 12127.1 12179.3 12188.3 16766.3 16768.1 16778.7 16783.2 16802.7 7968.5 8208.3 8458.5 8477.0 8498.2 7691.5 7762.6 7874.3 7909.4 8121.7 4639.0 4923.5 4924.9 5112.2 5130.8 1856.4 1928.0 1934.4 2017.4 2048.7 837.1 876.2 895.1 991.1 1043.4 18394.9 19396.3 19408.0 19449.3 19486.3 986.3 1010.1 1012.8 1074.6 1078.6 10217.4 11000.7 11052.3 11054.9 11082.7 523499.0 523576.0 532835.0 540252.0 550999.0 98534.5 99341.0 102331.0 104712.0 107835.0 1015.5 1069.1 1069.4 1073.7 1091.1 16789.7 17053.7 17180.9 17671.4 17973.0 40805.0 43832.3 43919.6 44596.3 45382.8 56733.7 62530.4 62706.0 64206.4 64305.0 8116.3 8317.4 8370.0 8409.5 9202.4 11833.0 13305.7 13348.8 13369.0 13830.9 11795.2 11816.8 12124.3 12434.6 12449.5 11646.2 11687.3 11827.8 11909.9 12262.9 11971.8 12070.8 12142.9 12417.8 12615.3 8080.9 8235.2 8695.6 11445.9 12483.8 12375.4 12778.5 13052.7 13076.9 13150.7 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | [#3] mootools.html Cycles:180 Average:5568.89 Median:4949.65 stddev:3059.66 (61.8%) stddev-sans-first:3052.60 19:13:55 INFO - PROCESS | 8885 | Values: 1451.5 1490.1 1577.4 1715.1 1726.2 7719.5 8188.4 8262.7 8264.4 8271.5 7532.8 7764.8 8168.4 8230.9 8360.3 2299.2 2319.0 2324.2 2333.9 2335.4 2379.9 2383.1 2420.1 2433.4 2439.1 2391.1 2393.4 2412.0 2413.9 2414.0 2273.5 2279.1 2297.0 2299.4 2307.3 2330.1 2334.0 2351.9 2354.0 2357.1 8501.8 8575.0 8589.2 8593.1 8598.6 4941.7 5119.6 5121.7 5125.4 5128.5 3165.3 3186.0 3214.2 3240.9 3363.2 1056.9 1076.9 1088.7 1094.5 1097.1 11051.2 11103.1 11117.8 11136.3 11147.6 4344.5 4469.1 4512.4 4533.8 4644.5 9926.3 9941.2 9944.1 9963.1 9980.6 5235.7 5239.5 5242.7 5246.6 5252.3 4259.8 4285.0 4760.7 4771.8 4840.9 3981.0 4057.7 4108.9 4117.3 4146.2 1315.5 1316.8 1322.8 1330.1 1331.1 991.2 996.4 998.6 1004.5 1020.7 6071.7 6110.3 6128.8 6194.9 6209.9 446.4 456.1 467.5 475.5 476.8 4189.1 4234.4 4296.8 4307.6 4341.1 10096.2 10117.7 10219.8 10344.2 10433.9 10285.2 10303.2 10304.5 10308.3 10316.8 7893.6 7972.6 8020.1 8040.3 8044.9 5949.5 5960.3 6000.2 6003.2 6157.0 9391.9 9412.5 9467.4 9517.5 9522.4 9503.6 9608.0 9634.7 9656.8 9710.0 6927.5 7111.9 7131.9 7341.6 7428.1 7788.5 8103.2 8104.6 8108.4 8115.4 7110.8 7163.8 7203.5 7241.2 7340.1 7202.1 7262.3 7280.1 7292.1 7321.2 6795.0 6908.2 6909.1 6909.1 6910.5 4893.9 5064.8 5064.9 5181.1 5313.9 4807.2 4919.7 4957.6 5022.2 5094.3 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | [#4] prototype.html Cycles:180 Average:4698.76 Median:5396.31 stddev:1372.03 (25.4%) stddev-sans-first:1335.89 19:13:55 INFO - PROCESS | 8885 | Values: 317.8 327.9 328.7 333.0 335.0 5239.7 5389.8 5402.8 5456.5 5499.3 5175.9 5319.6 5347.1 5354.1 5382.2 4175.2 4191.6 4193.5 4207.2 4222.4 4112.8 4183.3 4190.1 4227.9 4236.1 4136.7 4165.6 4165.9 4171.1 4173.3 4159.6 4166.3 4178.3 4179.3 4207.6 3735.5 3741.7 3748.9 3749.4 3753.4 5058.6 5226.3 5228.7 5240.7 5241.7 4764.4 4780.2 4791.0 4792.0 4833.2 5512.1 5659.9 5661.3 5664.3 5674.5 4038.8 4049.2 4059.3 4069.8 4086.6 5775.6 5831.3 5839.6 5844.7 5845.8 4155.7 4165.6 4183.4 4191.6 4205.9 4053.2 4167.2 4193.0 4194.6 4196.0 4740.9 4745.6 4746.6 4754.1 4761.2 5623.5 5625.2 5625.5 5638.5 5650.3 1331.3 1342.3 1372.7 1401.6 1401.8 952.3 959.6 967.5 970.1 976.6 5299.4 5302.8 5303.8 5304.2 5331.3 5536.5 5568.1 5570.3 5575.6 5605.9 5189.6 5289.4 5293.8 5324.4 5495.9 2950.9 2974.0 2991.6 2999.2 2999.3 5677.9 5711.6 5718.3 5720.4 5732.9 5571.7 5657.7 5693.6 5706.1 5706.9 5689.7 5704.9 5722.9 5734.3 5780.8 5426.6 5648.4 5681.1 5691.7 5713.3 5507.8 5535.5 5579.9 5611.4 5642.5 5709.3 5716.3 5716.4 5720.5 5746.3 3869.8 3974.6 3983.1 4003.7 4023.6 5616.0 5671.1 5686.9 5687.6 5705.5 5537.6 5627.9 5696.8 5701.1 5709.5 5603.9 5677.9 5692.5 5695.8 5709.0 5505.8 5603.5 5645.1 5653.2 5657.3 5687.4 5693.3 5700.1 5702.3 5725.9 5404.5 5556.4 5594.0 5617.2 5628.2 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - PROCESS | 8885 | [#5] yui.html Cycles:180 Average:17815.80 Median:48391.90 stddev:23301.94 (48.2%) stddev-sans-first:23332.12 19:13:55 INFO - PROCESS | 8885 | Values: 761.5 801.5 818.3 821.6 856.8 15101.2 15891.8 16030.8 16059.7 16065.0 14433.7 14539.6 14586.3 14599.3 14603.3 703.8 716.4 809.1 834.3 843.4 853.7 856.8 856.9 857.7 858.1 904.1 904.2 905.3 906.2 907.1 726.9 748.0 855.7 878.5 900.0 653.5 653.6 653.8 653.8 654.2 14757.2 14763.9 14825.4 14829.3 14875.2 13001.3 13061.9 13393.5 13418.1 13790.0 12832.1 12867.9 12893.0 12896.5 13189.9 4218.2 4221.6 4226.6 4241.2 4276.7 63332.0 63603.7 63608.0 63965.7 64763.0 10720.3 10728.4 10992.0 11087.7 11211.7 20902.9 21126.6 21325.0 21403.5 21550.7 8283.3 8343.7 8365.9 8575.8 8620.4 4315.2 4444.4 4490.6 4509.2 4559.6 3260.3 3364.4 3369.8 3371.4 3387.3 576.3 580.3 591.1 591.8 600.5 626.8 647.7 704.9 713.2 738.5 9249.4 9356.1 9495.3 9608.0 9673.5 669.2 670.2 682.8 706.2 737.7 4496.5 4549.1 4549.9 4557.6 4669.5 86173.6 86398.6 87118.1 91065.5 94352.0 47795.8 48356.0 49301.0 75102.9 75698.0 69597.3 70252.3 71050.6 72587.0 73171.0 9063.5 9230.8 9231.9 9259.7 9300.2 48427.8 49322.8 50287.5 50465.7 50658.0 63738.0 66758.7 68588.7 68694.3 71432.0 11127.0 11228.1 11245.0 11471.7 11700.7 12091.7 12113.8 12161.1 12222.8 12289.0 10958.6 13074.3 13138.0 13181.2 13239.1 13141.7 13462.6 13549.0 13680.3 13867.6 12943.0 13154.7 13370.3 13681.7 14159.9 11449.7 11606.9 11628.9 11785.9 12108.3 9964.9 10753.4 11434.9 11528.1 11581.7 19:13:55 INFO - PROCESS | 8885 | -------- Summary: end -------- 19:13:55 INFO - PROCESS | 8885 | 19:13:55 INFO - TEST-INFO | 8885: exit 0 19:13:56 INFO - TEST-OK | dromaeo_css | took 1115126ms 19:13:56 INFO - TEST-START | kraken 19:13:56 INFO - operating with platform_type : linux_ 19:13:56 INFO - Initialising browser for kraken test... 19:13:56 INFO - TEST-INFO | started process 9201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4HOUe/profile http://localhost:53231/getInfo.html) 19:14:00 INFO - PROCESS | 9201 | __metrics Screen width/height:1600/1200 19:14:00 INFO - PROCESS | 9201 | colorDepth:24 19:14:00 INFO - PROCESS | 9201 | Browser inner width/height: 1024/697 19:14:00 INFO - PROCESS | 9201 | __metrics 19:14:00 INFO - PROCESS | 9201 | 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" 19:14:00 INFO - PROCESS | 9201 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:14:01 INFO - PROCESS | 9201 | console.error: PushService: 19:14:01 INFO - PROCESS | 9201 | stateChangeProcessEnqueue: Error transitioning state 19:14:01 INFO - PROCESS | 9201 | UnknownError 19:14:01 INFO - TEST-INFO | 9201: exit 0 19:14:01 INFO - Browser initialized. 19:14:01 INFO - Running cycle 1/1 for kraken test... 19:14:01 INFO - TEST-INFO | started process 9293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa4HOUe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:13 INFO - PROCESS | 9293 | RSS: Main: 144187392 19:14:13 INFO - PROCESS | 9293 | 19:14:16 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53231/tests/kraken/driver.html?testName=audio-beat-detection) 19:14:17 INFO - PROCESS | 9293 | RSS: Main: 185761792 19:14:17 INFO - PROCESS | 9293 | 19:14:19 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53231/tests/kraken/driver.html?testName=audio-dft) 19:14:20 INFO - PROCESS | 9293 | RSS: Main: 175300608 19:14:20 INFO - PROCESS | 9293 | 19:14:23 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53231/tests/kraken/driver.html?testName=audio-fft) 19:14:23 INFO - PROCESS | 9293 | RSS: Main: 266645504 19:14:23 INFO - PROCESS | 9293 | 19:14:25 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53231/tests/kraken/driver.html?testName=audio-oscillator) 19:14:26 INFO - PROCESS | 9293 | RSS: Main: 173027328 19:14:26 INFO - PROCESS | 9293 | 19:14:28 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:14:29 INFO - PROCESS | 9293 | RSS: Main: 175464448 19:14:29 INFO - PROCESS | 9293 | 19:14:32 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53231/tests/kraken/driver.html?testName=imaging-darkroom) 19:14:32 INFO - PROCESS | 9293 | RSS: Main: 213487616 19:14:32 INFO - PROCESS | 9293 | 19:14:35 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53231/tests/kraken/driver.html?testName=imaging-desaturate) 19:14:36 INFO - PROCESS | 9293 | RSS: Main: 211927040 19:14:36 INFO - PROCESS | 9293 | 19:14:39 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53231/tests/kraken/driver.html?testName=json-parse-financial) 19:14:39 INFO - PROCESS | 9293 | RSS: Main: 211554304 19:14:39 INFO - PROCESS | 9293 | 19:14:41 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:14:41 INFO - PROCESS | 9293 | RSS: Main: 173993984 19:14:41 INFO - PROCESS | 9293 | 19:14:43 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:14:44 INFO - PROCESS | 9293 | RSS: Main: 180109312 19:14:44 INFO - PROCESS | 9293 | 19:14:46 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:14:46 INFO - PROCESS | 9293 | RSS: Main: 189476864 19:14:46 INFO - PROCESS | 9293 | 19:14:49 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:14:49 INFO - PROCESS | 9293 | RSS: Main: 198520832 19:14:49 INFO - PROCESS | 9293 | 19:14:52 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:14:53 INFO - PROCESS | 9293 | RSS: Main: 194543616 19:14:53 INFO - PROCESS | 9293 | 19:14:54 INFO - PROCESS | 9293 | Cycle 1(1): loaded http://localhost:53231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53231/tests/kraken/driver.html?testName=ai-astar) 19:14:55 INFO - PROCESS | 9293 | RSS: Main: 246689792 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | __start_tp_report 19:14:55 INFO - PROCESS | 9293 | _x_x_mozilla_page_load 19:14:55 INFO - PROCESS | 9293 | _x_x_mozilla_page_load_details 19:14:55 INFO - PROCESS | 9293 | |i|pagename|runs| 19:14:55 INFO - PROCESS | 9293 | |0;ai-astar;105;111;112;112;117;112;114;112;113;110 19:14:55 INFO - PROCESS | 9293 | |1;audio-beat-detection;148;115;116;156;118;119;116;120;146;121 19:14:55 INFO - PROCESS | 9293 | |2;audio-dft;161;161;161;162;161;163;162;161;162;161 19:14:55 INFO - PROCESS | 9293 | |3;audio-fft;75;75;75;110;76;76;75;77;99;75 19:14:55 INFO - PROCESS | 9293 | |4;audio-oscillator;82;82;121;81;81;83;98;82;81;111 19:14:55 INFO - PROCESS | 9293 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 19:14:55 INFO - PROCESS | 9293 | |6;imaging-darkroom;147;146;145;147;146;146;148;148;147;147 19:14:55 INFO - PROCESS | 9293 | |7;imaging-desaturate;85;85;85;85;84;85;85;84;85;85 19:14:55 INFO - PROCESS | 9293 | |8;json-parse-financial;50;50;50;52;51;51;52;50;51;51 19:14:55 INFO - PROCESS | 9293 | |9;json-stringify-tinderbox;59;59;59;60;61;60;60;59;59;59 19:14:55 INFO - PROCESS | 9293 | |10;stanford-crypto-aes;76;75;75;75;81;74;74;76;74;74 19:14:55 INFO - PROCESS | 9293 | |11;stanford-crypto-ccm;122;131;134;123;129;131;127;119;160;124 19:14:55 INFO - PROCESS | 9293 | |12;stanford-crypto-pbkdf2;152;159;152;152;156;151;153;153;153;153 19:14:55 INFO - PROCESS | 9293 | |13;stanford-crypto-sha256-iterative;62;63;65;63;62;62;63;66;61;60 19:14:55 INFO - PROCESS | 9293 | __end_tp_report 19:14:55 INFO - PROCESS | 9293 | __start_cc_report 19:14:55 INFO - PROCESS | 9293 | _x_x_mozilla_cycle_collect,1579 19:14:55 INFO - PROCESS | 9293 | __end_cc_report 19:14:55 INFO - PROCESS | 9293 | __startTimestamp1484277295000__endTimestamp 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | ------- Summary: start ------- 19:14:55 INFO - PROCESS | 9293 | Number of tests: 14 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:3.05 (2.7%) stddev-sans-first:2.01 19:14:55 INFO - PROCESS | 9293 | Values: 105.0 111.0 112.0 112.0 117.0 112.0 114.0 112.0 113.0 110.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:120.50 stddev:15.83 (13.1%) stddev-sans-first:14.96 19:14:55 INFO - PROCESS | 9293 | Values: 148.0 115.0 116.0 156.0 118.0 119.0 116.0 120.0 146.0 121.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 19:14:55 INFO - PROCESS | 9293 | Values: 161.0 161.0 161.0 162.0 161.0 163.0 162.0 161.0 162.0 161.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:12.52 (16.6%) stddev-sans-first:13.07 19:14:55 INFO - PROCESS | 9293 | Values: 75.0 75.0 75.0 110.0 76.0 76.0 75.0 77.0 99.0 75.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:14.72 (17.9%) stddev-sans-first:15.31 19:14:55 INFO - PROCESS | 9293 | Values: 82.0 82.0 121.0 81.0 81.0 83.0 98.0 82.0 81.0 111.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:14:55 INFO - PROCESS | 9293 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 19:14:55 INFO - PROCESS | 9293 | Values: 147.0 146.0 145.0 147.0 146.0 146.0 148.0 148.0 147.0 147.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 19:14:55 INFO - PROCESS | 9293 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 19:14:55 INFO - PROCESS | 9293 | Values: 50.0 50.0 50.0 52.0 51.0 51.0 52.0 50.0 51.0 51.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 19:14:55 INFO - PROCESS | 9293 | Values: 59.0 59.0 59.0 60.0 61.0 60.0 60.0 59.0 59.0 59.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:2.12 (2.8%) stddev-sans-first:2.24 19:14:55 INFO - PROCESS | 9293 | Values: 76.0 75.0 75.0 75.0 81.0 74.0 74.0 76.0 74.0 74.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:130.00 stddev:11.54 (8.9%) stddev-sans-first:11.87 19:14:55 INFO - PROCESS | 9293 | Values: 122.0 131.0 134.0 123.0 129.0 131.0 127.0 119.0 160.0 124.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:153.00 stddev:2.37 (1.5%) stddev-sans-first:2.46 19:14:55 INFO - PROCESS | 9293 | Values: 152.0 159.0 152.0 152.0 156.0 151.0 153.0 153.0 153.0 153.0 19:14:55 INFO - PROCESS | 9293 | 19:14:55 INFO - PROCESS | 9293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.77 (2.8%) stddev-sans-first:1.86 19:14:55 INFO - PROCESS | 9293 | Values: 62.0 63.0 65.0 63.0 62.0 62.0 63.0 66.0 61.0 60.0 19:14:55 INFO - PROCESS | 9293 | -------- Summary: end -------- 19:14:55 INFO - PROCESS | 9293 | 19:14:56 INFO - TEST-INFO | 9293: exit 0 19:14:56 INFO - TEST-OK | kraken | took 60096ms 19:14:56 INFO - SUITE-END | took 1175s 19:14:56 INFO - Completed test suite (00:19:35) 19:14:56 INFO - javascript benchmark 19:14:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3207.3424947885687, 3247.561579186809, 3257.2345498807776, 3260.7717459777796, 3286.0963235110344, 5459.918101228484, 5528.944710552893, 5540.196671482643, 5540.252065971088, 5543.944560554403, 5555.694436805974, 5587.8603034924145, 5593.161025846125, 5594.328680558328, 5600.0, 5026.572741316983, 5054.292399064116, 5083.491650834924, 5096.108181068298, 5154.304168937202, 4915.115279249733, 4931.605471562267, 5116.079105760961, 5164.664296820694, 5172.172452407615, 4939.160342741725, 4959.628027897922, 4971.6271279654175, 5009.9749501252445, 5031.094403007457, 5027.0, 5058.367704036977, 5128.102582048164, 5129.230615407681, 5159.14874045782, 4833.178359678828, 5035.370578677665, 5049.419316778581, 5072.67027643202, 5106.591472682177, 5330.173823057432, 5337.279467271907, 5367.382750983609, 5390.0, 5437.782488700447, 5804.361520232771, 5808.157817116495, 5907.911381329283, 5910.113482977545, 5912.556558258105, 5750.683712395817, 5929.614575052651, 5943.3462319144855, 5946.375630558772, 5954.642721436728, 5359.008583412081, 5552.555795536347, 5569.721513924287, 5582.525485333711, 5670.943290567124, 6121.663308517986, 6163.044728067157, 6168.136460895478, 6168.753249870045, 6171.7531298748445, 5692.1461780733225, 5927.525797936155, 5927.525797936155, 5933.762649493972, 5934.851628709317, 5805.564582656318, 5852.795152169739, 5878.147668588031, 5882.0, 5963.135345374896, 5889.646621202742, 5897.292324921037, 5900.6164599301765, 5900.675462849585, 5902.0, 5833.766649333979, 5897.734601942923, 5899.46904778572, 5901.793437229762, 5916.970415147896, 4461.308497182942, 4486.057927835126, 4541.091781643684, 4560.771961401917, 4561.384213131251, 4074.5162885732866, 4089.3661482470266, 4105.035316700573, 4116.91766164681, 4123.484564429446, 5674.06377947634, 5681.0, 5681.715914204273, 5685.715714214355, 5717.799877004368, 5759.798407055733, 5804.796832110856, 5859.296884373817, 5933.0, 5960.523158147338, 5675.602707810413, 5679.517241034476, 5679.716014199274, 5707.514861236758, 5729.656220626693, 5096.821611243663, 5100.030994111107, 5105.132127538327, 5110.28456016158, 5135.537801597874, 5753.798617048383, 5867.295924489089, 5931.733072011683, 5975.073863551156, 5997.160397544348, 5850.619709718854, 5937.643741375531, 5945.137954996588, 5960.225170727777, 5974.1636170935235, 5930.05119180929, 6013.218281623361, 6013.819585412444, 6022.488088512526, 6023.096535519707, 5693.772249109989, 5789.91315130265, 5809.796657116981, 5812.476877081083, 5815.79644712433, 5783.16144159103, 5845.035569131216, 5880.411958804086, 5890.14592884038, 5965.075413310944, 5757.366689664217, 5794.0, 5799.797007104731, 5802.564807639528, 5816.47651711348, 5776.508996735324, 5781.4218578141845, 5787.0, 5787.797427090031, 5790.826275211751, 5497.670139791625, 5613.382527921844, 5661.433856614306, 5688.146777983336, 5697.4302569742695, 5819.388964158702, 5821.446962538552, 5828.329742079545, 5829.067349224104, 5830.47525722687, 5600.075987462186, 5637.041702910433, 5665.3201615806365, 5687.658740475585, 5691.0], "value": 5450.819129228546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5489950188107, 608.7412849538946, 641.3009819296965, 665.733706517393, 681.9693113809878, 33633.327333453315, 45646.54353456465, 46471.76764116183, 46517.53482465178, 46568.068638627294, 45649.0870182597, 46061.53938460623, 46204.0, 46218.76890615542, 46229.30656040162, 8367.703006034075, 8959.552022398886, 9108.453492790453, 9109.498977556264, 9111.544422778868, 8375.371847111492, 10549.683509494727, 10801.40592267425, 10811.675649730481, 11094.722631934186, 11021.283616564897, 11060.336379817196, 11085.556577736921, 11088.390138542378, 11089.889101109007, 10819.0, 10864.239503234738, 10868.782624347468, 10873.782524349548, 10888.128949684085, 10718.839217411667, 10796.838047429295, 10800.297980631234, 10800.5679772809, 10801.621943232029, 43854.34218486693, 44166.33750493745, 44315.55684443179, 44376.33435498438, 44404.333934991, 3665.120371110914, 3722.236941427001, 3727.0682329417646, 3777.263433630443, 4096.365063415175, 30850.0, 33359.83320083384, 33778.0, 33805.661943380495, 34482.0, 4155.2728272552185, 4167.83328666853, 4170.145120250341, 4214.494260688706, 4256.914861702749, 343880.0, 349664.0, 350339.2483037594, 350770.99999999744, 352537.0, 66968.33031669621, 67714.32285677179, 67872.6606366965, 67929.0, 67975.0, 41618.37572436416, 42177.0, 42423.0, 44563.0, 71940.0, 18195.0, 18363.357282495315, 18378.448646540626, 18380.0, 18386.448406547825, 12724.554640587536, 12953.611391658265, 13210.867891321155, 13400.994925380635, 13538.187708737507, 21184.881511849, 22207.66688499674, 22373.888130559244, 22381.664275035888, 22400.215992440186, 7593.506422082547, 7697.384209263246, 7727.304542591194, 7781.727639532589, 7800.92199078002, 988.5502096546054, 1026.7587117027492, 1038.714353552764, 1039.111559616517, 1052.4948024947914, 33484.665153348156, 34202.31595368079, 34261.0, 34432.96701098971, 34685.826570866986, 1144.0275765599174, 1154.6709187881413, 1194.623698483708, 1198.1373411143963, 1219.5609580550995, 17267.74098388525, 17961.461156165336, 18214.0, 18231.088445577934, 18306.725399119023, 510212.0, 514466.0, 516510.0, 516625.0, 516925.1537423189, 62873.68563157155, 62897.685511573065, 63098.36901631017, 63248.683756580926, 63562.68218658877, 1220.1702842067302, 1220.664317312746, 1330.4079684540286, 1367.924764137962, 1378.9724205516034, 30598.235044123183, 34161.0, 34948.0, 35096.824515877255, 35296.29407411889, 53336.46663533315, 53778.0, 54013.72993135009, 54031.459685402646, 54130.18804718011, 399514.0, 399701.0, 402928.0, 403956.0, 509980.0, 45972.770136149105, 46688.766556167, 46726.0, 46773.766131169126, 47561.5243847571, 49418.75290623524, 49998.25002625036, 50494.74752626213, 50748.49251507438, 51056.48943510517, 42193.78903105465, 42494.36258456064, 43264.13471730611, 43443.782781085894, 47398.52601474079, 42536.78731606322, 42937.0, 43260.783696081315, 44127.558724413626, 44448.0, 43195.136097278504, 43234.56765432431, 43915.78042109769, 44314.778426108955, 44458.9993450302, 36066.4590031155, 38628.6137138625, 38701.41947870728, 38900.6109938897, 39363.01592460097, 29375.0, 29846.10461686153, 29920.700792991793, 29952.550711739776, 30154.0], "value": 21510.699623089662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.5841339718611, 401.87742738464794, 408.48938826466923, 418.7843260720728, 423.419914716838, 14639.853601463983, 16366.672666546661, 19356.3225287115, 19975.800241997575, 20112.0, 19726.901365493188, 20097.0, 20247.59504809903, 20282.0, 20549.897250513764, 5560.527355174815, 5569.0, 5699.686517241571, 5761.740721667514, 5767.884642307151, 4320.935185972197, 5571.1086226203815, 5653.23681303025, 5669.262995810539, 5671.0, 4542.227821270376, 6029.397060293957, 6308.684565771716, 6319.968400157993, 6420.93579064208, 6128.662923539226, 6329.68351582419, 6375.6174629522375, 6409.0, 6409.102725618417, 5655.632383895034, 5656.943430565683, 5657.377688454267, 5666.575006874501, 5712.428757124296, 24175.879120604284, 24302.0, 24444.266671999692, 24471.510569788683, 24559.263222103367, 2413.7706917842775, 2519.1560827122935, 2528.6645178672984, 2692.4211294571564, 2809.2134202423354, 14730.926345368205, 14894.255287235595, 15132.092074475566, 15243.39026438941, 15581.844181558266, 1908.9045547722696, 1962.9901850490655, 2025.9594808103902, 2043.5042905607722, 2079.625667379871, 78576.0, 92946.07053929442, 93154.5342273291, 94133.52933235359, 95343.52328238385, 10487.0, 11560.190786645022, 12127.09046821492, 12179.330136842558, 12188.268703877795, 16766.329346826235, 16768.07775572331, 16778.6644267114, 16783.1608419581, 16802.663946720997, 7968.482048666818, 8208.302294305051, 8458.492490450593, 8477.0, 8498.150184981576, 7691.46159768822, 7762.573058481725, 7874.330681892104, 7909.446338756347, 8121.715739949192, 4638.95361046392, 4923.532264434873, 4924.852254432372, 5112.156494178494, 5130.7947682093045, 1856.3595559531939, 1927.9614407711767, 1934.429343343717, 2017.3544465770813, 2048.723422337995, 837.1419295222446, 876.202655583416, 895.10684901433, 991.0733464210986, 1043.4487677628126, 18394.908025459787, 19396.295426495384, 19408.0, 19449.31927382535, 19486.317978870673, 986.3194395866828, 1010.1211945607222, 1012.7569383348091, 1074.6023971130733, 1078.5577913055608, 10217.438040907673, 11000.702999965086, 11052.281601695864, 11054.944725276322, 11082.722931926766, 523499.0, 523576.0, 532835.0, 540252.0, 550999.0, 98534.50732746434, 99341.0, 102331.0, 104712.0, 107835.0, 1015.5227043289642, 1069.096613361708, 1069.4332004037717, 1073.7369344510646, 1091.1161958813386, 16789.748153777946, 17053.65892682164, 17180.91409542944, 17671.38150164738, 17973.0, 40805.0, 43832.342514861666, 43919.56080439155, 44596.33105503485, 45382.77308613436, 56733.71633141808, 62530.37469625427, 62706.0, 64206.35793642004, 64305.0, 8116.2695357418115, 8317.41778075529, 8369.995600527976, 8409.53747543891, 9202.401843880127, 11833.0, 13305.667358315732, 13348.799768003293, 13369.0, 13830.930845345709, 11795.233309834834, 11816.82274765862, 12124.265993484521, 12434.56479023266, 12449.502019919102, 11646.242994205688, 11687.298762074302, 11827.763444731228, 11909.94045029804, 12262.877371226174, 11971.76056478883, 12070.758584828078, 12142.878571214174, 12417.813732793835, 12615.30615816139, 8080.9191908080165, 8235.176482351717, 8695.608712601963, 11445.942770286096, 12483.75032499363, 12375.443105060114, 12778.488860445477, 13052.738945220852, 13076.934615326862, 13150.671233219246], "value": 9660.472673158049, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.5282533176714, 1490.128274959149, 1577.3611687266662, 1715.1338574020126, 1726.1628110366478, 7719.4982326148765, 8188.385871059672, 8262.669493220279, 8264.421490495668, 8271.462354946923, 7532.849343013137, 7764.805879853006, 8168.387370947173, 8230.91769082309, 8360.289375403083, 2299.1952816514254, 2319.0, 2324.2097686786487, 2333.88330583471, 2335.439494521311, 2379.881005949704, 2383.0586918167314, 2420.092465325503, 2433.3794882304987, 2439.0609615298063, 2391.0674836813655, 2393.44950661348, 2411.9758802411925, 2413.8793060347, 2414.022320960014, 2273.545290941802, 2279.122537822942, 2296.9770302297015, 2299.390661474719, 2307.2847417300522, 2330.0912644068826, 2333.9533209335887, 2351.8941647625898, 2354.0, 2357.0689577616918, 8501.82996340076, 8575.0, 8589.184027517376, 8593.097724738875, 8598.5700714964, 4941.678790878617, 5119.56483698886, 5121.6670916390685, 5125.359330083739, 5128.461511541309, 3165.335279591289, 3185.9681403185905, 3214.164317277501, 3240.902772916816, 3363.243270264171, 1056.8995945385177, 1076.8976947190004, 1088.7495875948575, 1094.5129417409255, 1097.0729733375285, 11051.17116216287, 11103.111751059976, 11117.777644447066, 11136.33182009082, 11147.609833655782, 4344.456942882077, 4469.061497085649, 4512.435945506812, 4533.84131555394, 4644.489106198315, 9926.255530835217, 9941.204703623693, 9944.055314745088, 9963.103320701171, 9980.600775969026, 5235.712035837989, 5239.47605239473, 5242.659227150223, 5246.632735708464, 5252.264682944391, 4259.829606815692, 4285.035866929916, 4760.666753327303, 4771.785269662804, 4840.854774356775, 3980.960190398117, 4057.655099316591, 4108.897277568085, 4117.3206420940805, 4146.212219678251, 1315.4540865540885, 1316.8288122544009, 1322.8478724946563, 1330.1287656584952, 1331.1414137881206, 991.1624677147798, 996.4071377530358, 998.5556427389741, 1004.4927311707687, 1020.7193021919031, 6071.696415179224, 6110.327863934964, 6128.846778830476, 6194.938050619527, 6209.9068513972325, 446.4174252600323, 456.1128604863509, 467.4647528579757, 475.4698511160101, 476.7640018191018, 4189.120284740238, 4234.449521562177, 4296.849610263625, 4307.6338511226895, 4341.066670665822, 10096.192304615613, 10117.696469105938, 10219.795604087876, 10344.224183186141, 10433.895661043292, 10285.22860785444, 10303.227257955683, 10304.536295866705, 10308.278420510493, 10316.793664126675, 7893.565853878092, 7972.60136993148, 8020.11778704342, 8040.316573091236, 8044.919550804417, 5949.494292985145, 5960.284765828128, 6000.159977603052, 6003.249593800775, 6157.0, 9391.906080939103, 9412.482313472825, 9467.384619999679, 9517.524123793644, 9522.381045232038, 9503.572339244889, 9608.0, 9634.71095867125, 9656.806863862543, 9710.0, 6927.480438966997, 7111.928880711127, 7131.928680713127, 7341.559506429631, 7428.145763237297, 7788.493747906368, 8103.189681031849, 8104.594770261346, 8108.351331893552, 8115.391345648982, 7110.786676399716, 7163.820904477429, 7203.459740519377, 7241.239669834592, 7340.1191856975365, 7202.135743710788, 7262.273772622695, 7280.0535930328715, 7292.088488938883, 7321.231270716498, 6795.048693183057, 6908.205556361083, 6909.1018167639895, 6909.136357955255, 6910.516263861481, 4893.853184404474, 5064.772085256246, 5064.949350506595, 5181.093308671043, 5313.893722125613, 4807.206810876166, 4919.704817710949, 4957.628177886745, 5022.17134172872, 5094.2867998479505], "value": 4451.57292542383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.7892230601407, 327.8770461077096, 328.6828210776601, 332.9766916315857, 335.03676928829617, 5239.738013099349, 5389.83830485086, 5402.783888644454, 5456.508914197717, 5499.257600223968, 5175.870603234921, 5319.627626066167, 5347.112559218018, 5354.14333706607, 5382.2195781611645, 4175.164967006595, 4191.622753952143, 4193.490343476361, 4207.20063187994, 4222.37438586145, 4112.773797441139, 4183.330667093266, 4190.141021090669, 4227.87316380509, 4236.131593023439, 4136.738294820078, 4165.604267594589, 4165.854195103172, 4171.124063946575, 4173.311403618414, 4159.646430053464, 4166.312558427856, 4178.26880295947, 4179.26862799009, 4207.621314081747, 3735.533058367704, 3741.719371047155, 3748.9437658435145, 3749.4000959846567, 3753.4369844523267, 5058.570021548173, 5226.320578324831, 5228.660137091077, 5240.737963101829, 5241.711705856176, 4764.356811830393, 4780.211265141283, 4791.0, 4791.976040119777, 4833.202521583935, 5512.145617429305, 5659.886802263973, 5661.2923384576925, 5664.291963504562, 5674.460926212003, 4038.757674539537, 4049.230646177217, 4059.289624315733, 4069.837206511736, 4086.5504794472586, 5775.5957083004205, 5831.271091113611, 5839.649621022752, 5844.736986835603, 5845.824625261206, 4155.688323375698, 4165.645920096765, 4183.435236243129, 4191.64371028466, 4205.915881682349, 4053.1691003344245, 4167.187398457332, 4192.993681516414, 4194.643455306333, 4196.0, 4740.905181896343, 4745.572898439157, 4746.620270378361, 4754.096721622881, 4761.238201887751, 5623.493885550321, 5625.184348269559, 5625.549956003591, 5638.464345887134, 5650.26546548946, 1331.2944139605831, 1342.2617560341773, 1372.6980064385818, 1401.5563969111831, 1401.7897315402568, 952.2810278239884, 959.5538074795114, 967.4582233949011, 970.1365784451843, 976.5800705696619, 5299.3905700844125, 5302.787888484418, 5303.753617899791, 5304.230886521433, 5331.333583302087, 5536.529395001389, 5568.106843673089, 5570.3315602128005, 5575.581831362664, 5605.859853503695, 5189.558887494605, 5289.444608316148, 5293.814716484904, 5324.361076670747, 5495.862603434946, 2950.8967186148384, 2973.9702602973694, 2991.5811786349927, 2999.1602351341658, 2999.2801727585224, 5677.886442271214, 5711.600187986801, 5718.285214348207, 5720.367566595159, 5732.914006289909, 5571.693556854412, 5657.688827114548, 5693.572982026365, 5706.089894154012, 5706.885862282731, 5689.743961521742, 5704.857378565486, 5722.885542289131, 5734.283214598176, 5780.768769249351, 5426.647267927572, 5648.435156484319, 5681.125228674445, 5691.658500489983, 5713.257276554022, 5507.807226747044, 5535.501804837584, 5579.888402231852, 5611.382747897646, 5642.463965923231, 5709.343425505954, 5716.28546431696, 5716.42835716425, 5720.513756330759, 5746.310442746897, 3869.7871617061332, 3974.6224108709625, 3983.143624120828, 4003.7197396181987, 4023.637872591481, 5615.971920140373, 5671.092625179951, 5686.943130568641, 5687.60186786921, 5705.4579814917515, 5537.612367134423, 5627.915581266202, 5696.772129114789, 5701.116326969326, 5709.51469125129, 5603.943960560342, 5677.914831277451, 5692.459216374438, 5695.772169113189, 5709.0, 5505.834824955257, 5603.523700485504, 5645.096784514458, 5653.208550802973, 5657.349404818498, 5687.374388817144, 5693.345265294379, 5700.144978253295, 5702.287214098238, 5725.8568535786935, 5404.486573775485, 5556.416576259435, 5594.021046316797, 5617.185508101385, 5628.1557766333735], "value": 4257.238466404051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.4593638516653, 801.4990630855715, 818.3207937411947, 821.5768879027298, 856.7601071699922, 15101.169435681033, 15891.761623575656, 16030.839691603094, 16059.700298901364, 16065.036097834109, 14433.711325773478, 14539.636509087279, 14586.343614537345, 14599.27003649816, 14603.269836508185, 703.820525765929, 716.3910675925474, 809.0776514773163, 834.2991886815074, 843.4306842881061, 853.6884037326394, 856.8115014696757, 856.8500512410335, 857.6740838481369, 858.1418581418582, 904.1230006893336, 904.2404380320529, 905.307439808547, 906.1572737354257, 907.0702529906865, 726.9055022847023, 748.0462410426695, 855.7475544714324, 878.4729162502512, 899.9595018224196, 653.4804830160034, 653.6045692356151, 653.7744478155076, 653.8267359149829, 654.1594051643663, 14757.18835464049, 14763.852361476354, 14825.406983720639, 14829.25853707321, 14875.181864997421, 13001.284929328884, 13061.86938130616, 13393.531226407029, 13418.060735748502, 13790.0, 12832.101752877303, 12867.935660321733, 12893.0, 12896.484140634364, 13189.86810131896, 4218.156368726267, 4221.5567365426805, 4226.598473145046, 4241.2365774160635, 4276.655507715651, 63332.0, 63603.6819815898, 63608.0, 63965.680171599306, 64763.0, 10720.303180293256, 10728.356298622108, 10992.0, 11087.667369978913, 11211.71970700739, 20902.89548552278, 21126.577468450545, 21325.0, 21403.46491337729, 21550.676739848914, 8283.29591984676, 8343.666253349798, 8365.916340836635, 8575.785605359915, 8620.396572239883, 4315.244832154423, 4444.377787109807, 4490.573395527485, 4509.210888094571, 4559.589636932692, 3260.3316320154313, 3364.4280472319765, 3369.848356823949, 3371.4268574342423, 3387.305602351512, 576.3199424678835, 580.3152280309191, 591.0985746736176, 591.8490784849836, 600.4835841176584, 626.8495561065403, 647.7052940911874, 704.9259827718118, 713.1905287498727, 738.5310327941795, 9249.445033298023, 9356.111169438893, 9495.335326527076, 9607.951960240294, 9673.516324183762, 669.1568623534382, 670.1957650819037, 682.8429461223947, 706.2421245038134, 737.6643627149741, 4496.505384407713, 4549.112922980054, 4549.909001819945, 4557.5898169164275, 4669.533046695304, 86173.56913215393, 86398.56800715956, 87118.12881871227, 91065.54467227621, 94352.0, 47795.761021194674, 48356.03287934292, 49301.0, 75102.87345689819, 75698.0, 69597.30402695909, 70252.2974770256, 71050.64474677698, 72587.0, 73171.0, 9063.456192628464, 9230.769230769016, 9231.86152207704, 9259.72220833376, 9300.162985331353, 48427.75786121047, 49322.753386234275, 50287.49712502828, 50465.74767126141, 50658.0, 63738.0, 66758.66620666865, 68588.65705671639, 68694.31305686879, 71432.0, 11127.0, 11228.101751859995, 11245.0, 11471.713207169887, 11700.70748231301, 12091.697707557381, 12113.818292725793, 12161.148719589544, 12222.75554488923, 12289.0, 10958.563769261016, 13074.28091454979, 13138.0, 13181.209127452, 13239.073264871367, 13141.671458213621, 13462.596122116352, 13549.0, 13680.31598420095, 13867.583972480841, 12943.0, 13154.671133221746, 13370.331483425984, 13681.726365472436, 14159.858401415853, 11449.656510304705, 11606.94196529012, 11628.94185529067, 11785.941070294593, 12108.304837322958, 9964.900350996397, 10753.354798712102, 11434.94282528582, 11528.135389845962, 11581.652550423501], "value": 7201.041708995366, "unit": "score"}], "name": "dromaeo_css", "value": 7325.997179476974, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 112.0, 117.0, 112.0, 114.0, 112.0, 113.0, 110.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 116.0, 156.0, 118.0, 119.0, 116.0, 120.0, 146.0, 121.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 162.0, 161.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 110.0, 76.0, 76.0, 75.0, 77.0, 99.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 121.0, 81.0, 81.0, 83.0, 98.0, 82.0, 81.0, 111.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.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, 85.0, 84.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 52.0, 51.0, 51.0, 52.0, 50.0, 51.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 61.0, 60.0, 60.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 75.0, 81.0, 74.0, 74.0, 76.0, 74.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 134.0, 123.0, 129.0, 131.0, 127.0, 119.0, 160.0, 124.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 152.0, 152.0, 156.0, 151.0, 153.0, 153.0, 153.0, 153.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 63.0, 62.0, 62.0, 63.0, 66.0, 61.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1452.5000000000002, "alertThreshold": 2.0}]} 19:14:56 INFO - Return code: 0 19:14:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:14:56 INFO - # TBPL SUCCESS # 19:14:56 INFO - Running post-action listener: _resource_record_post_action 19:14:56 INFO - [mozharness: 2017-01-13 03:14:56.302547Z] Finished run-tests step (success) 19:14:56 INFO - Running post-run listener: _resource_record_post_run 19:14:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 355987456; Read time: 0; Write time: 242200 19:14:56 INFO - TinderboxPrint: CPU usage
13.0% 19:14:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:14:56 INFO - TinderboxPrint: I/O write bytes / time
355,987,456 / 242,200 19:14:56 INFO - TinderboxPrint: CPU idle
8,268.1 (87.0%) 19:14:56 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 19:14:56 INFO - TinderboxPrint: Swap in / out
0 / 0 19:14:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108281856; Read time: 0; Write time: 93752 19:14:56 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247705600; Read time: 0; Write time: 148448 19:14:56 INFO - Running post-run listener: _upload_blobber_files 19:14:56 INFO - Blob upload gear active. 19:14:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:14:56 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 19:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:14:57 INFO - (blobuploader) - INFO - Open directory for files ... 19:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:58 INFO - (blobuploader) - INFO - Done attempting. 19:14:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:14:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:01 INFO - (blobuploader) - INFO - Done attempting. 19:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:02 INFO - (blobuploader) - INFO - Done attempting. 19:15:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:15:02 INFO - Return code: 0 19:15:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:15:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:15:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a6f53197fd47916381b231c28ccf38560bcc8c5eb467f0b5bbd2312f7907fd6faa7df044bd7e71642c4b72381f1ac258fd27314ba52563573457152a3d99677", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82818c590cf418d16ff8b394d20368b5b21f3c379c23c79d91537e00936e7e0f713d3c141f9949eacbfa2664da0b6a0a9d015e745b9ee0737b60d20face147ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d2f2cfd54f5202271c45f15dcc30eb493811399b474a92813231b7b9f57d7f49e995a9380966526e67719edfd7635710442452b4264c5c531f2c01faba901ff"} 19:15:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:15:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:15:02 INFO - Contents: 19:15:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a6f53197fd47916381b231c28ccf38560bcc8c5eb467f0b5bbd2312f7907fd6faa7df044bd7e71642c4b72381f1ac258fd27314ba52563573457152a3d99677", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82818c590cf418d16ff8b394d20368b5b21f3c379c23c79d91537e00936e7e0f713d3c141f9949eacbfa2664da0b6a0a9d015e745b9ee0737b60d20face147ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d2f2cfd54f5202271c45f15dcc30eb493811399b474a92813231b7b9f57d7f49e995a9380966526e67719edfd7635710442452b4264c5c531f2c01faba901ff"} 19:15:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:15:02 INFO - Copying logs to upload dir... 19:15:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:15:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.816945 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 19:15:01.193878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 19:15:01.197742) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a6f53197fd47916381b231c28ccf38560bcc8c5eb467f0b5bbd2312f7907fd6faa7df044bd7e71642c4b72381f1ac258fd27314ba52563573457152a3d99677", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82818c590cf418d16ff8b394d20368b5b21f3c379c23c79d91537e00936e7e0f713d3c141f9949eacbfa2664da0b6a0a9d015e745b9ee0737b60d20face147ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d2f2cfd54f5202271c45f15dcc30eb493811399b474a92813231b7b9f57d7f49e995a9380966526e67719edfd7635710442452b4264c5c531f2c01faba901ff"} build_url:https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/Tv1SjB0JSM2hcjkOZ7yQgA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a6f53197fd47916381b231c28ccf38560bcc8c5eb467f0b5bbd2312f7907fd6faa7df044bd7e71642c4b72381f1ac258fd27314ba52563573457152a3d99677", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82818c590cf418d16ff8b394d20368b5b21f3c379c23c79d91537e00936e7e0f713d3c141f9949eacbfa2664da0b6a0a9d015e745b9ee0737b60d20face147ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d2f2cfd54f5202271c45f15dcc30eb493811399b474a92813231b7b9f57d7f49e995a9380966526e67719edfd7635710442452b4264c5c531f2c01faba901ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 19:15:01.226665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 19:15:01.227218) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1484276063.945995-2079707063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 19:15:01.309021) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 19:15:01.309350) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 19:15:01.309648) ========= ========= Total master_lag: 0.16 =========